Oct 9 00:54:25.891327 kernel: Linux version 6.6.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Oct 8 23:33:43 -00 2024 Oct 9 00:54:25.891349 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 verity.usrhash=ecc53326196a1bacd9ba781ce772ef34cdd5fe5561cf830307501ec3d5ba168a Oct 9 00:54:25.891360 kernel: BIOS-provided physical RAM map: Oct 9 00:54:25.891367 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Oct 9 00:54:25.891373 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Oct 9 00:54:25.891379 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Oct 9 00:54:25.891386 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Oct 9 00:54:25.891393 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Oct 9 00:54:25.891399 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Oct 9 00:54:25.891407 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Oct 9 00:54:25.891413 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Oct 9 00:54:25.891419 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Oct 9 00:54:25.891425 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Oct 9 00:54:25.891432 kernel: NX (Execute Disable) protection: active Oct 9 00:54:25.891439 kernel: APIC: Static calls initialized Oct 9 00:54:25.891448 kernel: SMBIOS 2.8 present. Oct 9 00:54:25.891455 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Oct 9 00:54:25.891462 kernel: Hypervisor detected: KVM Oct 9 00:54:25.891469 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 9 00:54:25.891475 kernel: kvm-clock: using sched offset of 2229785304 cycles Oct 9 00:54:25.891482 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 9 00:54:25.891489 kernel: tsc: Detected 2794.748 MHz processor Oct 9 00:54:25.891496 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 9 00:54:25.891503 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 9 00:54:25.891510 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Oct 9 00:54:25.891519 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Oct 9 00:54:25.891526 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 9 00:54:25.891533 kernel: Using GB pages for direct mapping Oct 9 00:54:25.891540 kernel: ACPI: Early table checksum verification disabled Oct 9 00:54:25.891547 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Oct 9 00:54:25.891554 kernel: ACPI: RSDT 0x000000009CFE2408 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891568 kernel: ACPI: FACP 0x000000009CFE21E8 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891575 kernel: ACPI: DSDT 0x000000009CFE0040 0021A8 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891584 kernel: ACPI: FACS 0x000000009CFE0000 000040 Oct 9 00:54:25.891590 kernel: ACPI: APIC 0x000000009CFE22DC 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891597 kernel: ACPI: HPET 0x000000009CFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891604 kernel: ACPI: MCFG 0x000000009CFE23A4 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891611 kernel: ACPI: WAET 0x000000009CFE23E0 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:54:25.891618 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21e8-0x9cfe22db] Oct 9 00:54:25.891625 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21e7] Oct 9 00:54:25.891635 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Oct 9 00:54:25.891644 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22dc-0x9cfe236b] Oct 9 00:54:25.891651 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe236c-0x9cfe23a3] Oct 9 00:54:25.891658 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23a4-0x9cfe23df] Oct 9 00:54:25.891665 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23e0-0x9cfe2407] Oct 9 00:54:25.891672 kernel: No NUMA configuration found Oct 9 00:54:25.891680 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Oct 9 00:54:25.891687 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Oct 9 00:54:25.891696 kernel: Zone ranges: Oct 9 00:54:25.891703 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 9 00:54:25.891710 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Oct 9 00:54:25.891717 kernel: Normal empty Oct 9 00:54:25.891725 kernel: Movable zone start for each node Oct 9 00:54:25.891732 kernel: Early memory node ranges Oct 9 00:54:25.891739 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Oct 9 00:54:25.891746 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Oct 9 00:54:25.891753 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Oct 9 00:54:25.891762 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 9 00:54:25.891771 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Oct 9 00:54:25.891779 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Oct 9 00:54:25.891787 kernel: ACPI: PM-Timer IO Port: 0x608 Oct 9 00:54:25.891796 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 9 00:54:25.891803 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 9 00:54:25.891810 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 9 00:54:25.891817 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 9 00:54:25.891824 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 9 00:54:25.891833 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 9 00:54:25.891840 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 9 00:54:25.891848 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 9 00:54:25.891855 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 9 00:54:25.891862 kernel: TSC deadline timer available Oct 9 00:54:25.891869 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Oct 9 00:54:25.891876 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Oct 9 00:54:25.891883 kernel: kvm-guest: KVM setup pv remote TLB flush Oct 9 00:54:25.891890 kernel: kvm-guest: setup PV sched yield Oct 9 00:54:25.891897 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Oct 9 00:54:25.891907 kernel: Booting paravirtualized kernel on KVM Oct 9 00:54:25.891914 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 9 00:54:25.891921 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Oct 9 00:54:25.891928 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288 Oct 9 00:54:25.891936 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152 Oct 9 00:54:25.891942 kernel: pcpu-alloc: [0] 0 1 2 3 Oct 9 00:54:25.891949 kernel: kvm-guest: PV spinlocks enabled Oct 9 00:54:25.891957 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 9 00:54:25.891965 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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 verity.usrhash=ecc53326196a1bacd9ba781ce772ef34cdd5fe5561cf830307501ec3d5ba168a Oct 9 00:54:25.891975 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 9 00:54:25.891982 kernel: random: crng init done Oct 9 00:54:25.891989 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 9 00:54:25.891996 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 9 00:54:25.892003 kernel: Fallback order for Node 0: 0 Oct 9 00:54:25.892010 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 Oct 9 00:54:25.892017 kernel: Policy zone: DMA32 Oct 9 00:54:25.892025 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 9 00:54:25.892035 kernel: Memory: 2434592K/2571752K available (12288K kernel code, 2305K rwdata, 22728K rodata, 42872K init, 2316K bss, 136900K reserved, 0K cma-reserved) Oct 9 00:54:25.892042 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 9 00:54:25.892049 kernel: ftrace: allocating 37786 entries in 148 pages Oct 9 00:54:25.892056 kernel: ftrace: allocated 148 pages with 3 groups Oct 9 00:54:25.892063 kernel: Dynamic Preempt: voluntary Oct 9 00:54:25.892071 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 9 00:54:25.892083 kernel: rcu: RCU event tracing is enabled. Oct 9 00:54:25.892090 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 9 00:54:25.892098 kernel: Trampoline variant of Tasks RCU enabled. Oct 9 00:54:25.892108 kernel: Rude variant of Tasks RCU enabled. Oct 9 00:54:25.892115 kernel: Tracing variant of Tasks RCU enabled. Oct 9 00:54:25.892122 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 9 00:54:25.892129 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 9 00:54:25.892136 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Oct 9 00:54:25.892144 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 9 00:54:25.892151 kernel: Console: colour VGA+ 80x25 Oct 9 00:54:25.892158 kernel: printk: console [ttyS0] enabled Oct 9 00:54:25.892165 kernel: ACPI: Core revision 20230628 Oct 9 00:54:25.892175 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Oct 9 00:54:25.892182 kernel: APIC: Switch to symmetric I/O mode setup Oct 9 00:54:25.892189 kernel: x2apic enabled Oct 9 00:54:25.892196 kernel: APIC: Switched APIC routing to: physical x2apic Oct 9 00:54:25.892203 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Oct 9 00:54:25.892211 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Oct 9 00:54:25.892218 kernel: kvm-guest: setup PV IPIs Oct 9 00:54:25.892235 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 9 00:54:25.892243 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Oct 9 00:54:25.892250 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Oct 9 00:54:25.892279 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 9 00:54:25.892296 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Oct 9 00:54:25.892308 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Oct 9 00:54:25.892315 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 9 00:54:25.892323 kernel: Spectre V2 : Mitigation: Retpolines Oct 9 00:54:25.892331 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 9 00:54:25.892338 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 9 00:54:25.892348 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Oct 9 00:54:25.892356 kernel: RETBleed: Mitigation: untrained return thunk Oct 9 00:54:25.892363 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 9 00:54:25.892371 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Oct 9 00:54:25.892379 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Oct 9 00:54:25.892387 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Oct 9 00:54:25.892394 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Oct 9 00:54:25.892402 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 9 00:54:25.892412 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 9 00:54:25.892419 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 9 00:54:25.892427 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 9 00:54:25.892434 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Oct 9 00:54:25.892442 kernel: Freeing SMP alternatives memory: 32K Oct 9 00:54:25.892449 kernel: pid_max: default: 32768 minimum: 301 Oct 9 00:54:25.892457 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 9 00:54:25.892465 kernel: landlock: Up and running. Oct 9 00:54:25.892472 kernel: SELinux: Initializing. Oct 9 00:54:25.892482 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:54:25.892490 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:54:25.892497 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Oct 9 00:54:25.892505 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:54:25.892512 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:54:25.892520 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:54:25.892527 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Oct 9 00:54:25.892535 kernel: ... version: 0 Oct 9 00:54:25.892542 kernel: ... bit width: 48 Oct 9 00:54:25.892552 kernel: ... generic registers: 6 Oct 9 00:54:25.892564 kernel: ... value mask: 0000ffffffffffff Oct 9 00:54:25.892572 kernel: ... max period: 00007fffffffffff Oct 9 00:54:25.892579 kernel: ... fixed-purpose events: 0 Oct 9 00:54:25.892587 kernel: ... event mask: 000000000000003f Oct 9 00:54:25.892594 kernel: signal: max sigframe size: 1776 Oct 9 00:54:25.892602 kernel: rcu: Hierarchical SRCU implementation. Oct 9 00:54:25.892610 kernel: rcu: Max phase no-delay instances is 400. Oct 9 00:54:25.892617 kernel: smp: Bringing up secondary CPUs ... Oct 9 00:54:25.892627 kernel: smpboot: x86: Booting SMP configuration: Oct 9 00:54:25.892635 kernel: .... node #0, CPUs: #1 #2 #3 Oct 9 00:54:25.892642 kernel: smp: Brought up 1 node, 4 CPUs Oct 9 00:54:25.892649 kernel: smpboot: Max logical packages: 1 Oct 9 00:54:25.892657 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Oct 9 00:54:25.892664 kernel: devtmpfs: initialized Oct 9 00:54:25.892672 kernel: x86/mm: Memory block size: 128MB Oct 9 00:54:25.892679 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 9 00:54:25.892687 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 9 00:54:25.892696 kernel: pinctrl core: initialized pinctrl subsystem Oct 9 00:54:25.892704 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 9 00:54:25.892711 kernel: audit: initializing netlink subsys (disabled) Oct 9 00:54:25.892719 kernel: audit: type=2000 audit(1728435265.975:1): state=initialized audit_enabled=0 res=1 Oct 9 00:54:25.892726 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 9 00:54:25.892734 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 9 00:54:25.892741 kernel: cpuidle: using governor menu Oct 9 00:54:25.892748 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 9 00:54:25.892756 kernel: dca service started, version 1.12.1 Oct 9 00:54:25.892766 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Oct 9 00:54:25.892773 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Oct 9 00:54:25.892781 kernel: PCI: Using configuration type 1 for base access Oct 9 00:54:25.892789 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 9 00:54:25.892796 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 9 00:54:25.892804 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 9 00:54:25.892811 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 9 00:54:25.892819 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 9 00:54:25.892826 kernel: ACPI: Added _OSI(Module Device) Oct 9 00:54:25.892836 kernel: ACPI: Added _OSI(Processor Device) Oct 9 00:54:25.892843 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 9 00:54:25.892851 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 9 00:54:25.892858 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 9 00:54:25.892866 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Oct 9 00:54:25.892873 kernel: ACPI: Interpreter enabled Oct 9 00:54:25.892880 kernel: ACPI: PM: (supports S0 S3 S5) Oct 9 00:54:25.892888 kernel: ACPI: Using IOAPIC for interrupt routing Oct 9 00:54:25.892895 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 9 00:54:25.892905 kernel: PCI: Using E820 reservations for host bridge windows Oct 9 00:54:25.892913 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Oct 9 00:54:25.892920 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 9 00:54:25.893097 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 9 00:54:25.893226 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Oct 9 00:54:25.893382 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Oct 9 00:54:25.893393 kernel: PCI host bridge to bus 0000:00 Oct 9 00:54:25.893523 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 9 00:54:25.893646 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 9 00:54:25.893759 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 9 00:54:25.893871 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Oct 9 00:54:25.893981 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Oct 9 00:54:25.894091 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Oct 9 00:54:25.894200 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 9 00:54:25.894369 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Oct 9 00:54:25.894506 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Oct 9 00:54:25.894636 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Oct 9 00:54:25.894757 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Oct 9 00:54:25.894882 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Oct 9 00:54:25.895000 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 9 00:54:25.895132 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Oct 9 00:54:25.895270 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Oct 9 00:54:25.895394 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Oct 9 00:54:25.895515 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Oct 9 00:54:25.895655 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Oct 9 00:54:25.895776 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Oct 9 00:54:25.895896 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Oct 9 00:54:25.896016 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Oct 9 00:54:25.896148 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Oct 9 00:54:25.896284 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Oct 9 00:54:25.896408 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Oct 9 00:54:25.896527 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Oct 9 00:54:25.896654 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Oct 9 00:54:25.896787 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Oct 9 00:54:25.896911 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Oct 9 00:54:25.897038 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Oct 9 00:54:25.897157 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Oct 9 00:54:25.897311 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Oct 9 00:54:25.897441 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Oct 9 00:54:25.897567 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Oct 9 00:54:25.897578 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 9 00:54:25.897590 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 9 00:54:25.897597 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 9 00:54:25.897605 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 9 00:54:25.897613 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Oct 9 00:54:25.897621 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Oct 9 00:54:25.897629 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Oct 9 00:54:25.897636 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Oct 9 00:54:25.897644 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Oct 9 00:54:25.897651 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Oct 9 00:54:25.897661 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Oct 9 00:54:25.897669 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Oct 9 00:54:25.897676 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Oct 9 00:54:25.897684 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Oct 9 00:54:25.897691 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Oct 9 00:54:25.897699 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Oct 9 00:54:25.897707 kernel: iommu: Default domain type: Translated Oct 9 00:54:25.897714 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 9 00:54:25.897722 kernel: PCI: Using ACPI for IRQ routing Oct 9 00:54:25.897732 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 9 00:54:25.897739 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Oct 9 00:54:25.897747 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Oct 9 00:54:25.897873 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Oct 9 00:54:25.898007 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Oct 9 00:54:25.898127 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 9 00:54:25.898137 kernel: vgaarb: loaded Oct 9 00:54:25.898144 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 9 00:54:25.898156 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Oct 9 00:54:25.898164 kernel: clocksource: Switched to clocksource kvm-clock Oct 9 00:54:25.898171 kernel: VFS: Disk quotas dquot_6.6.0 Oct 9 00:54:25.898179 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 9 00:54:25.898186 kernel: pnp: PnP ACPI init Oct 9 00:54:25.898338 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Oct 9 00:54:25.898349 kernel: pnp: PnP ACPI: found 6 devices Oct 9 00:54:25.898357 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 9 00:54:25.898369 kernel: NET: Registered PF_INET protocol family Oct 9 00:54:25.898376 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 9 00:54:25.898384 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 9 00:54:25.898392 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 9 00:54:25.898399 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 9 00:54:25.898407 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 9 00:54:25.898414 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 9 00:54:25.898422 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:54:25.898430 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:54:25.898439 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 9 00:54:25.898447 kernel: NET: Registered PF_XDP protocol family Oct 9 00:54:25.898567 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 9 00:54:25.898679 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 9 00:54:25.898789 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 9 00:54:25.898898 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Oct 9 00:54:25.899009 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Oct 9 00:54:25.899118 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Oct 9 00:54:25.899132 kernel: PCI: CLS 0 bytes, default 64 Oct 9 00:54:25.899139 kernel: Initialise system trusted keyrings Oct 9 00:54:25.899147 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 9 00:54:25.899154 kernel: Key type asymmetric registered Oct 9 00:54:25.899162 kernel: Asymmetric key parser 'x509' registered Oct 9 00:54:25.899170 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 9 00:54:25.899177 kernel: io scheduler mq-deadline registered Oct 9 00:54:25.899185 kernel: io scheduler kyber registered Oct 9 00:54:25.899192 kernel: io scheduler bfq registered Oct 9 00:54:25.899200 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 9 00:54:25.899210 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Oct 9 00:54:25.899218 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Oct 9 00:54:25.899226 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Oct 9 00:54:25.899233 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 9 00:54:25.899241 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 9 00:54:25.899249 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 9 00:54:25.899274 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 9 00:54:25.902318 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 9 00:54:25.902499 kernel: rtc_cmos 00:04: RTC can wake from S4 Oct 9 00:54:25.902522 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 9 00:54:25.902647 kernel: rtc_cmos 00:04: registered as rtc0 Oct 9 00:54:25.902770 kernel: rtc_cmos 00:04: setting system clock to 2024-10-09T00:54:25 UTC (1728435265) Oct 9 00:54:25.902910 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Oct 9 00:54:25.902923 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Oct 9 00:54:25.902933 kernel: NET: Registered PF_INET6 protocol family Oct 9 00:54:25.902941 kernel: Segment Routing with IPv6 Oct 9 00:54:25.902949 kernel: In-situ OAM (IOAM) with IPv6 Oct 9 00:54:25.902961 kernel: NET: Registered PF_PACKET protocol family Oct 9 00:54:25.902969 kernel: Key type dns_resolver registered Oct 9 00:54:25.902977 kernel: IPI shorthand broadcast: enabled Oct 9 00:54:25.902985 kernel: sched_clock: Marking stable (636003986, 106778049)->(758334127, -15552092) Oct 9 00:54:25.902993 kernel: registered taskstats version 1 Oct 9 00:54:25.903001 kernel: Loading compiled-in X.509 certificates Oct 9 00:54:25.903009 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: 03ae66f5ce294ce3ab718ee0d7c4a4a6e8c5aae6' Oct 9 00:54:25.903017 kernel: Key type .fscrypt registered Oct 9 00:54:25.903025 kernel: Key type fscrypt-provisioning registered Oct 9 00:54:25.903036 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 9 00:54:25.903044 kernel: ima: Allocated hash algorithm: sha1 Oct 9 00:54:25.903052 kernel: ima: No architecture policies found Oct 9 00:54:25.903060 kernel: clk: Disabling unused clocks Oct 9 00:54:25.903068 kernel: Freeing unused kernel image (initmem) memory: 42872K Oct 9 00:54:25.903076 kernel: Write protecting the kernel read-only data: 36864k Oct 9 00:54:25.903084 kernel: Freeing unused kernel image (rodata/data gap) memory: 1848K Oct 9 00:54:25.903092 kernel: Run /init as init process Oct 9 00:54:25.903102 kernel: with arguments: Oct 9 00:54:25.903110 kernel: /init Oct 9 00:54:25.903118 kernel: with environment: Oct 9 00:54:25.903126 kernel: HOME=/ Oct 9 00:54:25.903133 kernel: TERM=linux Oct 9 00:54:25.903141 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 9 00:54:25.903152 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) Oct 9 00:54:25.903163 systemd[1]: Detected virtualization kvm. Oct 9 00:54:25.903176 systemd[1]: Detected architecture x86-64. Oct 9 00:54:25.903184 systemd[1]: Running in initrd. Oct 9 00:54:25.903192 systemd[1]: No hostname configured, using default hostname. Oct 9 00:54:25.903200 systemd[1]: Hostname set to . Oct 9 00:54:25.903209 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:54:25.903217 systemd[1]: Queued start job for default target initrd.target. Oct 9 00:54:25.903226 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:54:25.903235 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:54:25.903248 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 9 00:54:25.903288 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:54:25.903299 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 9 00:54:25.903308 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 9 00:54:25.903319 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 9 00:54:25.903329 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 9 00:54:25.903338 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:54:25.903347 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:54:25.903355 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:54:25.903364 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:54:25.903373 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:54:25.903381 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:54:25.903390 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:54:25.903402 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:54:25.903410 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 9 00:54:25.903419 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 9 00:54:25.903428 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:54:25.903436 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:54:25.903445 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:54:25.903453 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:54:25.903462 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 9 00:54:25.903470 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:54:25.903482 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 9 00:54:25.903490 systemd[1]: Starting systemd-fsck-usr.service... Oct 9 00:54:25.903498 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:54:25.903507 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:54:25.903515 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:54:25.903524 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 9 00:54:25.903533 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:54:25.903541 systemd[1]: Finished systemd-fsck-usr.service. Oct 9 00:54:25.903580 systemd-journald[193]: Collecting audit messages is disabled. Oct 9 00:54:25.903607 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 00:54:25.903619 systemd-journald[193]: Journal started Oct 9 00:54:25.903637 systemd-journald[193]: Runtime Journal (/run/log/journal/fa0bfaae7a074c2cb9749a922d8621a2) is 6.0M, max 48.4M, 42.3M free. Oct 9 00:54:25.884693 systemd-modules-load[194]: Inserted module 'overlay' Oct 9 00:54:25.919675 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 9 00:54:25.919698 kernel: Bridge firewalling registered Oct 9 00:54:25.911829 systemd-modules-load[194]: Inserted module 'br_netfilter' Oct 9 00:54:25.921416 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:54:25.922774 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:54:25.925097 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:54:25.927506 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 00:54:25.944405 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:54:25.947509 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:54:25.950193 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:54:25.953174 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:54:25.963564 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:54:25.963863 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:54:25.967716 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:54:25.969715 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 00:54:25.974694 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:54:25.977460 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 9 00:54:25.994311 dracut-cmdline[230]: dracut-dracut-053 Oct 9 00:54:25.997303 dracut-cmdline[230]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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 verity.usrhash=ecc53326196a1bacd9ba781ce772ef34cdd5fe5561cf830307501ec3d5ba168a Oct 9 00:54:26.005320 systemd-resolved[228]: Positive Trust Anchors: Oct 9 00:54:26.005337 systemd-resolved[228]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:54:26.005369 systemd-resolved[228]: 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 Oct 9 00:54:26.007818 systemd-resolved[228]: Defaulting to hostname 'linux'. Oct 9 00:54:26.008823 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 00:54:26.014958 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:54:26.097286 kernel: SCSI subsystem initialized Oct 9 00:54:26.107281 kernel: Loading iSCSI transport class v2.0-870. Oct 9 00:54:26.117283 kernel: iscsi: registered transport (tcp) Oct 9 00:54:26.138290 kernel: iscsi: registered transport (qla4xxx) Oct 9 00:54:26.138324 kernel: QLogic iSCSI HBA Driver Oct 9 00:54:26.187661 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 9 00:54:26.199387 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 9 00:54:26.223881 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 9 00:54:26.223913 kernel: device-mapper: uevent: version 1.0.3 Oct 9 00:54:26.223930 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 9 00:54:26.264281 kernel: raid6: avx2x4 gen() 30175 MB/s Oct 9 00:54:26.281276 kernel: raid6: avx2x2 gen() 30902 MB/s Oct 9 00:54:26.298349 kernel: raid6: avx2x1 gen() 25845 MB/s Oct 9 00:54:26.298364 kernel: raid6: using algorithm avx2x2 gen() 30902 MB/s Oct 9 00:54:26.316359 kernel: raid6: .... xor() 19780 MB/s, rmw enabled Oct 9 00:54:26.316384 kernel: raid6: using avx2x2 recovery algorithm Oct 9 00:54:26.336284 kernel: xor: automatically using best checksumming function avx Oct 9 00:54:26.488287 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 9 00:54:26.501296 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:54:26.519383 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:54:26.533390 systemd-udevd[415]: Using default interface naming scheme 'v255'. Oct 9 00:54:26.538016 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:54:26.544395 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 9 00:54:26.557730 dracut-pre-trigger[418]: rd.md=0: removing MD RAID activation Oct 9 00:54:26.589742 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:54:26.602372 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:54:26.663074 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:54:26.667424 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 9 00:54:26.682676 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 9 00:54:26.683194 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:54:26.684794 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:54:26.685135 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:54:26.694388 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 9 00:54:26.704134 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:54:26.709732 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Oct 9 00:54:26.709967 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 9 00:54:26.712476 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:54:26.717344 kernel: cryptd: max_cpu_qlen set to 1000 Oct 9 00:54:26.728602 kernel: libata version 3.00 loaded. Oct 9 00:54:26.735460 kernel: ahci 0000:00:1f.2: version 3.0 Oct 9 00:54:26.735656 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Oct 9 00:54:26.737070 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Oct 9 00:54:26.737241 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Oct 9 00:54:26.738302 kernel: AVX2 version of gcm_enc/dec engaged. Oct 9 00:54:26.740439 kernel: AES CTR mode by8 optimization enabled Oct 9 00:54:26.742781 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:54:26.742902 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:54:26.745588 kernel: scsi host0: ahci Oct 9 00:54:26.750029 kernel: BTRFS: device fsid 6ed52ce5-b2f8-4d16-8889-677a209bc377 devid 1 transid 36 /dev/vda3 scanned by (udev-worker) (472) Oct 9 00:54:26.750051 kernel: scsi host1: ahci Oct 9 00:54:26.750558 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:54:26.754688 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (470) Oct 9 00:54:26.754707 kernel: scsi host2: ahci Oct 9 00:54:26.755377 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:54:26.757284 kernel: scsi host3: ahci Oct 9 00:54:26.757597 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:54:26.760101 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:54:26.767948 kernel: scsi host4: ahci Oct 9 00:54:26.768114 kernel: scsi host5: ahci Oct 9 00:54:26.768286 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Oct 9 00:54:26.768298 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Oct 9 00:54:26.768313 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Oct 9 00:54:26.768323 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Oct 9 00:54:26.768333 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Oct 9 00:54:26.768342 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Oct 9 00:54:26.773645 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:54:26.779656 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 9 00:54:26.794113 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 9 00:54:26.824285 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:54:26.829793 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 9 00:54:26.831104 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 9 00:54:26.838106 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:54:26.850378 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 9 00:54:26.851061 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:54:26.859365 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:54:26.865295 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:54:26.870323 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:54:27.075216 kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 9 00:54:27.075282 kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 9 00:54:27.075301 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 9 00:54:27.075311 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 9 00:54:27.076281 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Oct 9 00:54:27.077280 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 9 00:54:27.078286 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Oct 9 00:54:27.078298 kernel: ata3.00: applying bridge limits Oct 9 00:54:27.079278 kernel: ata3.00: configured for UDMA/100 Oct 9 00:54:27.081273 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Oct 9 00:54:27.129792 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Oct 9 00:54:27.130039 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 9 00:54:27.143282 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Oct 9 00:54:27.869280 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:54:27.869460 disk-uuid[556]: The operation has completed successfully. Oct 9 00:54:27.898596 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 9 00:54:27.898716 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 9 00:54:27.917377 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 9 00:54:27.920658 sh[591]: Success Oct 9 00:54:27.932281 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Oct 9 00:54:27.963680 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 9 00:54:27.974673 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 9 00:54:27.977230 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 9 00:54:27.991290 kernel: BTRFS info (device dm-0): first mount of filesystem 6ed52ce5-b2f8-4d16-8889-677a209bc377 Oct 9 00:54:27.991316 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 9 00:54:27.991327 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 9 00:54:27.993672 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 9 00:54:27.993689 kernel: BTRFS info (device dm-0): using free space tree Oct 9 00:54:27.997749 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 9 00:54:27.999196 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 9 00:54:28.009377 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 9 00:54:28.010963 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 9 00:54:28.019801 kernel: BTRFS info (device vda6): first mount of filesystem 7abc21fd-6b75-4be0-8205-dc564a91a608 Oct 9 00:54:28.019830 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 00:54:28.019841 kernel: BTRFS info (device vda6): using free space tree Oct 9 00:54:28.022282 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 00:54:28.030811 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 9 00:54:28.032491 kernel: BTRFS info (device vda6): last unmount of filesystem 7abc21fd-6b75-4be0-8205-dc564a91a608 Oct 9 00:54:28.040945 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 9 00:54:28.048405 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 9 00:54:28.139963 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 00:54:28.179105 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 00:54:28.184129 ignition[683]: Ignition 2.19.0 Oct 9 00:54:28.184139 ignition[683]: Stage: fetch-offline Oct 9 00:54:28.184178 ignition[683]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:28.184188 ignition[683]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:28.184303 ignition[683]: parsed url from cmdline: "" Oct 9 00:54:28.184307 ignition[683]: no config URL provided Oct 9 00:54:28.184312 ignition[683]: reading system config file "/usr/lib/ignition/user.ign" Oct 9 00:54:28.184321 ignition[683]: no config at "/usr/lib/ignition/user.ign" Oct 9 00:54:28.184354 ignition[683]: op(1): [started] loading QEMU firmware config module Oct 9 00:54:28.184361 ignition[683]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 9 00:54:28.196742 ignition[683]: op(1): [finished] loading QEMU firmware config module Oct 9 00:54:28.198021 ignition[683]: parsing config with SHA512: e99136dd8961cbd4157acefd0bc32a3c44128c17741fe73c1ed6d265e3daa10fc264c4e9ed36d3f88d4dc7b321650ce6639f3227071066706dc88c6b93ffbe38 Oct 9 00:54:28.200679 unknown[683]: fetched base config from "system" Oct 9 00:54:28.200692 unknown[683]: fetched user config from "qemu" Oct 9 00:54:28.201150 systemd-networkd[778]: lo: Link UP Oct 9 00:54:28.201154 systemd-networkd[778]: lo: Gained carrier Oct 9 00:54:28.202414 ignition[683]: fetch-offline: fetch-offline passed Oct 9 00:54:28.202674 systemd-networkd[778]: Enumeration completed Oct 9 00:54:28.202497 ignition[683]: Ignition finished successfully Oct 9 00:54:28.203123 systemd-networkd[778]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:54:28.203127 systemd-networkd[778]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 00:54:28.203238 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 00:54:28.204379 systemd-networkd[778]: eth0: Link UP Oct 9 00:54:28.204383 systemd-networkd[778]: eth0: Gained carrier Oct 9 00:54:28.204390 systemd-networkd[778]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:54:28.205005 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 00:54:28.207119 systemd[1]: Reached target network.target - Network. Oct 9 00:54:28.208498 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 9 00:54:28.216389 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 9 00:54:28.221377 systemd-networkd[778]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 00:54:28.229509 ignition[783]: Ignition 2.19.0 Oct 9 00:54:28.229519 ignition[783]: Stage: kargs Oct 9 00:54:28.229673 ignition[783]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:28.229684 ignition[783]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:28.230288 ignition[783]: kargs: kargs passed Oct 9 00:54:28.233580 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 9 00:54:28.230329 ignition[783]: Ignition finished successfully Oct 9 00:54:28.243418 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 9 00:54:28.267837 ignition[793]: Ignition 2.19.0 Oct 9 00:54:28.267848 ignition[793]: Stage: disks Oct 9 00:54:28.268014 ignition[793]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:28.268025 ignition[793]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:28.271561 ignition[793]: disks: disks passed Oct 9 00:54:28.271605 ignition[793]: Ignition finished successfully Oct 9 00:54:28.275007 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 9 00:54:28.276422 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 9 00:54:28.278328 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 9 00:54:28.280629 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:54:28.282841 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:54:28.284826 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:54:28.295429 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 9 00:54:28.305324 systemd-resolved[228]: Detected conflict on linux IN A 10.0.0.19 Oct 9 00:54:28.305340 systemd-resolved[228]: Hostname conflict, changing published hostname from 'linux' to 'linux4'. Oct 9 00:54:28.309296 systemd-fsck[805]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 9 00:54:28.315304 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 9 00:54:28.329328 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 9 00:54:28.414277 kernel: EXT4-fs (vda9): mounted filesystem ba2945c1-be14-41c0-8c54-84d676c7a16b r/w with ordered data mode. Quota mode: none. Oct 9 00:54:28.414990 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 9 00:54:28.417129 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 9 00:54:28.424342 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 00:54:28.425899 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 9 00:54:28.430362 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (813) Oct 9 00:54:28.427283 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 9 00:54:28.436581 kernel: BTRFS info (device vda6): first mount of filesystem 7abc21fd-6b75-4be0-8205-dc564a91a608 Oct 9 00:54:28.436602 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 00:54:28.436614 kernel: BTRFS info (device vda6): using free space tree Oct 9 00:54:28.436625 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 00:54:28.427320 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 9 00:54:28.427339 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 00:54:28.434134 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 9 00:54:28.437268 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 9 00:54:28.440756 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 00:54:28.471775 initrd-setup-root[837]: cut: /sysroot/etc/passwd: No such file or directory Oct 9 00:54:28.476633 initrd-setup-root[844]: cut: /sysroot/etc/group: No such file or directory Oct 9 00:54:28.480367 initrd-setup-root[851]: cut: /sysroot/etc/shadow: No such file or directory Oct 9 00:54:28.483839 initrd-setup-root[858]: cut: /sysroot/etc/gshadow: No such file or directory Oct 9 00:54:28.561784 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 9 00:54:28.570408 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 9 00:54:28.573754 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 9 00:54:28.577275 kernel: BTRFS info (device vda6): last unmount of filesystem 7abc21fd-6b75-4be0-8205-dc564a91a608 Oct 9 00:54:28.607766 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 9 00:54:28.609715 ignition[927]: INFO : Ignition 2.19.0 Oct 9 00:54:28.609715 ignition[927]: INFO : Stage: mount Oct 9 00:54:28.609715 ignition[927]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:28.609715 ignition[927]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:28.609715 ignition[927]: INFO : mount: mount passed Oct 9 00:54:28.609715 ignition[927]: INFO : Ignition finished successfully Oct 9 00:54:28.611008 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 9 00:54:28.624389 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 9 00:54:28.990670 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 9 00:54:29.002397 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 00:54:29.008278 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (940) Oct 9 00:54:29.008301 kernel: BTRFS info (device vda6): first mount of filesystem 7abc21fd-6b75-4be0-8205-dc564a91a608 Oct 9 00:54:29.010763 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 00:54:29.010777 kernel: BTRFS info (device vda6): using free space tree Oct 9 00:54:29.013278 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 00:54:29.014336 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 00:54:29.031748 ignition[957]: INFO : Ignition 2.19.0 Oct 9 00:54:29.031748 ignition[957]: INFO : Stage: files Oct 9 00:54:29.033435 ignition[957]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:29.033435 ignition[957]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:29.033435 ignition[957]: DEBUG : files: compiled without relabeling support, skipping Oct 9 00:54:29.033435 ignition[957]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 9 00:54:29.033435 ignition[957]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 9 00:54:29.039901 ignition[957]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 9 00:54:29.039901 ignition[957]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 9 00:54:29.039901 ignition[957]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Oct 9 00:54:29.039901 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Oct 9 00:54:29.039901 ignition[957]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Oct 9 00:54:29.039901 ignition[957]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 00:54:29.039901 ignition[957]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 00:54:29.039901 ignition[957]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Oct 9 00:54:29.039901 ignition[957]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Oct 9 00:54:29.035748 unknown[957]: wrote ssh authorized keys file for user: core Oct 9 00:54:29.066941 ignition[957]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 00:54:29.066941 ignition[957]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 00:54:29.066941 ignition[957]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Oct 9 00:54:29.066941 ignition[957]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 9 00:54:29.066941 ignition[957]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 9 00:54:29.066941 ignition[957]: INFO : files: files passed Oct 9 00:54:29.066941 ignition[957]: INFO : Ignition finished successfully Oct 9 00:54:29.065013 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 9 00:54:29.078369 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 9 00:54:29.080105 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 9 00:54:29.082031 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 9 00:54:29.082154 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 9 00:54:29.089081 initrd-setup-root-after-ignition[986]: grep: /sysroot/oem/oem-release: No such file or directory Oct 9 00:54:29.091355 initrd-setup-root-after-ignition[988]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:54:29.093006 initrd-setup-root-after-ignition[988]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:54:29.094571 initrd-setup-root-after-ignition[992]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:54:29.094816 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:54:29.097535 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 9 00:54:29.108411 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 9 00:54:29.131507 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 9 00:54:29.132544 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 9 00:54:29.135181 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 9 00:54:29.137195 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 9 00:54:29.139316 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 9 00:54:29.151388 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 9 00:54:29.166675 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:54:29.170464 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 9 00:54:29.183049 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:54:29.185483 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:54:29.187916 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 00:54:29.189985 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 9 00:54:29.191068 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:54:29.193654 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 9 00:54:29.195741 systemd[1]: Stopped target basic.target - Basic System. Oct 9 00:54:29.197589 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 9 00:54:29.199796 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 00:54:29.202106 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 9 00:54:29.204348 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 9 00:54:29.206427 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:54:29.208915 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 9 00:54:29.211012 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 9 00:54:29.213060 systemd[1]: Stopped target swap.target - Swaps. Oct 9 00:54:29.214697 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 9 00:54:29.215713 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:54:29.218007 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:54:29.220306 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:54:29.222666 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 9 00:54:29.223629 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:54:29.226267 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 9 00:54:29.227275 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 9 00:54:29.229532 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 9 00:54:29.230646 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 00:54:29.233043 systemd[1]: Stopped target paths.target - Path Units. Oct 9 00:54:29.234853 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 9 00:54:29.235982 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:54:29.238754 systemd[1]: Stopped target slices.target - Slice Units. Oct 9 00:54:29.240646 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 00:54:29.242589 systemd[1]: iscsid.socket: Deactivated successfully. Oct 9 00:54:29.243500 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:54:29.245522 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 9 00:54:29.246441 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:54:29.248511 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 9 00:54:29.249721 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:54:29.252313 systemd[1]: ignition-files.service: Deactivated successfully. Oct 9 00:54:29.253319 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 9 00:54:29.266400 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 9 00:54:29.268307 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 9 00:54:29.269344 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:54:29.272496 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 9 00:54:29.274284 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 9 00:54:29.275373 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:54:29.277720 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 9 00:54:29.278643 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:54:29.284539 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 9 00:54:29.284657 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 9 00:54:29.289286 ignition[1013]: INFO : Ignition 2.19.0 Oct 9 00:54:29.290614 ignition[1013]: INFO : Stage: umount Oct 9 00:54:29.290614 ignition[1013]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:54:29.290614 ignition[1013]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:54:29.290614 ignition[1013]: INFO : umount: umount passed Oct 9 00:54:29.290614 ignition[1013]: INFO : Ignition finished successfully Oct 9 00:54:29.292991 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 9 00:54:29.293110 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 9 00:54:29.293963 systemd[1]: Stopped target network.target - Network. Oct 9 00:54:29.296924 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 9 00:54:29.296977 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 9 00:54:29.297897 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 9 00:54:29.297941 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 9 00:54:29.298231 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 9 00:54:29.298340 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 9 00:54:29.298744 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 9 00:54:29.298787 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 9 00:54:29.299202 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 9 00:54:29.305056 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 9 00:54:29.313314 systemd-networkd[778]: eth0: DHCPv6 lease lost Oct 9 00:54:29.314889 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 9 00:54:29.315014 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 9 00:54:29.317575 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 9 00:54:29.317728 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 9 00:54:29.318806 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 9 00:54:29.318863 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:54:29.326363 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 9 00:54:29.328171 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 9 00:54:29.328226 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 00:54:29.329252 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 9 00:54:29.329311 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:54:29.332668 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 9 00:54:29.332714 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 9 00:54:29.334646 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 9 00:54:29.334694 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:54:29.335736 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:54:29.345290 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 9 00:54:29.345535 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 9 00:54:29.349518 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 9 00:54:29.353115 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 9 00:54:29.353233 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 9 00:54:29.355215 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 9 00:54:29.355288 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 9 00:54:29.357986 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 9 00:54:29.358166 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:54:29.360619 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 9 00:54:29.360670 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 9 00:54:29.362435 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 9 00:54:29.362486 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:54:29.364739 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 9 00:54:29.364788 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:54:29.366914 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 9 00:54:29.366962 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 9 00:54:29.368989 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:54:29.369036 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:54:29.380384 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 9 00:54:29.380452 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 9 00:54:29.380525 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:54:29.380835 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:54:29.380877 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:54:29.388620 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 9 00:54:29.388736 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 9 00:54:29.390855 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 9 00:54:29.393513 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 9 00:54:29.403632 systemd[1]: Switching root. Oct 9 00:54:29.439118 systemd-journald[193]: Journal stopped Oct 9 00:54:30.229737 systemd-journald[193]: Received SIGTERM from PID 1 (systemd). Oct 9 00:54:30.229800 kernel: SELinux: policy capability network_peer_controls=1 Oct 9 00:54:30.229819 kernel: SELinux: policy capability open_perms=1 Oct 9 00:54:30.229833 kernel: SELinux: policy capability extended_socket_class=1 Oct 9 00:54:30.229844 kernel: SELinux: policy capability always_check_network=0 Oct 9 00:54:30.229862 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 9 00:54:30.229873 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 9 00:54:30.229885 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 9 00:54:30.229896 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 9 00:54:30.229908 kernel: audit: type=1403 audit(1728435269.518:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 9 00:54:30.229930 systemd[1]: Successfully loaded SELinux policy in 38.935ms. Oct 9 00:54:30.229952 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.490ms. Oct 9 00:54:30.229967 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) Oct 9 00:54:30.229979 systemd[1]: Detected virtualization kvm. Oct 9 00:54:30.229991 systemd[1]: Detected architecture x86-64. Oct 9 00:54:30.230002 systemd[1]: Detected first boot. Oct 9 00:54:30.230014 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:54:30.230026 zram_generator::config[1059]: No configuration found. Oct 9 00:54:30.230038 systemd[1]: Populated /etc with preset unit settings. Oct 9 00:54:30.230050 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 9 00:54:30.230064 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 9 00:54:30.230076 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 9 00:54:30.230088 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 9 00:54:30.230100 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 9 00:54:30.230111 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 9 00:54:30.230123 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 9 00:54:30.230159 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 9 00:54:30.230182 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 9 00:54:30.230199 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 9 00:54:30.230210 systemd[1]: Created slice user.slice - User and Session Slice. Oct 9 00:54:30.230232 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:54:30.230244 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:54:30.230269 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 9 00:54:30.230281 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 9 00:54:30.230296 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 9 00:54:30.230308 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:54:30.230320 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 9 00:54:30.230345 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:54:30.230369 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 9 00:54:30.230390 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 9 00:54:30.230415 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 9 00:54:30.230438 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 9 00:54:30.230459 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:54:30.230471 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:54:30.230482 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:54:30.230494 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:54:30.230506 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 9 00:54:30.230518 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 9 00:54:30.230529 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:54:30.230541 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:54:30.230554 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:54:30.230569 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 9 00:54:30.230599 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 9 00:54:30.230611 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 9 00:54:30.230623 systemd[1]: Mounting media.mount - External Media Directory... Oct 9 00:54:30.230635 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.230647 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 9 00:54:30.230659 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 9 00:54:30.230671 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 9 00:54:30.230683 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). Oct 9 00:54:30.230698 systemd[1]: Reached target machines.target - Containers. Oct 9 00:54:30.230710 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 9 00:54:30.230722 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:54:30.230734 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:54:30.230746 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 9 00:54:30.230757 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:54:30.230769 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:54:30.230781 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:54:30.230795 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 9 00:54:30.230807 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:54:30.230819 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 9 00:54:30.230831 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 9 00:54:30.230844 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 9 00:54:30.230856 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 9 00:54:30.230867 systemd[1]: Stopped systemd-fsck-usr.service. Oct 9 00:54:30.230879 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:54:30.230891 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:54:30.230905 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 9 00:54:30.230917 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 9 00:54:30.230929 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:54:30.230940 kernel: fuse: init (API version 7.39) Oct 9 00:54:30.230952 systemd[1]: verity-setup.service: Deactivated successfully. Oct 9 00:54:30.230964 systemd[1]: Stopped verity-setup.service. Oct 9 00:54:30.230976 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.230988 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 9 00:54:30.231000 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 9 00:54:30.231014 systemd[1]: Mounted media.mount - External Media Directory. Oct 9 00:54:30.231025 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 9 00:54:30.231037 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 9 00:54:30.231068 systemd-journald[1136]: Collecting audit messages is disabled. Oct 9 00:54:30.231092 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 9 00:54:30.231104 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 9 00:54:30.231116 kernel: ACPI: bus type drm_connector registered Oct 9 00:54:30.231128 systemd-journald[1136]: Journal started Oct 9 00:54:30.231150 systemd-journald[1136]: Runtime Journal (/run/log/journal/fa0bfaae7a074c2cb9749a922d8621a2) is 6.0M, max 48.4M, 42.3M free. Oct 9 00:54:30.003409 systemd[1]: Queued start job for default target multi-user.target. Oct 9 00:54:30.021670 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 9 00:54:30.022100 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 9 00:54:30.235326 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:54:30.236278 kernel: loop: module loaded Oct 9 00:54:30.236371 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:54:30.238382 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 9 00:54:30.238595 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 9 00:54:30.240433 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:54:30.240631 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:54:30.242154 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:54:30.242347 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:54:30.244033 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:54:30.244212 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:54:30.245918 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 9 00:54:30.246103 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 9 00:54:30.247592 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:54:30.247787 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:54:30.249275 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:54:30.250845 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 9 00:54:30.252448 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 9 00:54:30.272090 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 9 00:54:30.277334 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 9 00:54:30.279584 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 9 00:54:30.280881 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 9 00:54:30.280911 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:54:30.282886 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 9 00:54:30.287675 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 9 00:54:30.291397 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 9 00:54:30.292625 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:54:30.294196 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 9 00:54:30.297815 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 9 00:54:30.299065 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:54:30.301873 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 9 00:54:30.304231 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:54:30.306918 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:54:30.310694 systemd-journald[1136]: Time spent on flushing to /var/log/journal/fa0bfaae7a074c2cb9749a922d8621a2 is 19.523ms for 921 entries. Oct 9 00:54:30.310694 systemd-journald[1136]: System Journal (/var/log/journal/fa0bfaae7a074c2cb9749a922d8621a2) is 8.0M, max 195.6M, 187.6M free. Oct 9 00:54:30.341571 systemd-journald[1136]: Received client request to flush runtime journal. Oct 9 00:54:30.312444 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:54:30.314687 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 9 00:54:30.319935 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:54:30.321386 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 9 00:54:30.324235 (sd-merge)[1175]: No extensions found. Oct 9 00:54:30.326187 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 9 00:54:30.327810 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 9 00:54:30.329535 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:54:30.332078 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 9 00:54:30.341508 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 9 00:54:30.349562 systemd[1]: Starting ensure-sysext.service... Oct 9 00:54:30.353504 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 9 00:54:30.358130 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 9 00:54:30.360133 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 9 00:54:30.361780 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:54:30.373021 systemd[1]: Reloading requested from client PID 1184 ('systemctl') (unit ensure-sysext.service)... Oct 9 00:54:30.373152 systemd[1]: Reloading... Oct 9 00:54:30.426399 zram_generator::config[1218]: No configuration found. Oct 9 00:54:30.687091 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 9 00:54:30.687331 systemd[1]: Reloading finished in 313 ms. Oct 9 00:54:30.704250 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 9 00:54:30.709751 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 9 00:54:30.747687 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:54:30.751783 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:54:30.756147 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.756282 udevadm[1187]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 9 00:54:30.757381 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:54:30.761456 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:54:30.764989 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:54:30.770084 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:54:30.771227 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:54:30.771365 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.776688 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.776847 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:54:30.776999 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:54:30.777085 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.777643 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:54:30.777817 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:54:30.782977 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:54:30.787930 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:54:30.788121 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:54:30.788775 systemd-tmpfiles[1257]: ACLs are not supported, ignoring. Oct 9 00:54:30.788790 systemd-tmpfiles[1257]: ACLs are not supported, ignoring. Oct 9 00:54:30.790490 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:54:30.790933 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:54:30.795290 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:54:30.799333 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.799525 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:54:30.802951 systemd-tmpfiles[1258]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 9 00:54:30.803232 systemd-tmpfiles[1258]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 9 00:54:30.804086 systemd-tmpfiles[1258]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 9 00:54:30.804384 systemd-tmpfiles[1258]: ACLs are not supported, ignoring. Oct 9 00:54:30.804455 systemd-tmpfiles[1258]: ACLs are not supported, ignoring. Oct 9 00:54:30.806807 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:54:30.809024 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:54:30.810170 systemd-tmpfiles[1258]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:54:30.810177 systemd-tmpfiles[1258]: Skipping /boot Oct 9 00:54:30.812582 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:54:30.812670 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:54:30.812727 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 00:54:30.813415 systemd[1]: Finished ensure-sysext.service. Oct 9 00:54:30.815171 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:54:30.815388 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:54:30.816909 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:54:30.817113 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:54:30.821528 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:54:30.823713 systemd-tmpfiles[1258]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:54:30.823728 systemd-tmpfiles[1258]: Skipping /boot Oct 9 00:54:30.866403 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:54:30.893478 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:54:30.897410 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 9 00:54:30.900537 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 9 00:54:30.906275 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 00:54:30.912440 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 9 00:54:30.915470 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 9 00:54:30.919883 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 9 00:54:30.925505 ldconfig[1168]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 9 00:54:30.940522 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 9 00:54:30.966972 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 9 00:54:30.972067 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 9 00:54:30.972129 augenrules[1302]: No rules Oct 9 00:54:30.974073 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:54:30.974287 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:54:30.991882 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 9 00:54:30.993354 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). Oct 9 00:54:30.997610 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 9 00:54:31.060087 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 9 00:54:31.061553 systemd[1]: Reached target time-set.target - System Time Set. Oct 9 00:54:31.066581 systemd-resolved[1278]: Positive Trust Anchors: Oct 9 00:54:31.066598 systemd-resolved[1278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:54:31.066631 systemd-resolved[1278]: 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 Oct 9 00:54:31.070030 systemd-resolved[1278]: Defaulting to hostname 'linux'. Oct 9 00:54:31.071590 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 00:54:31.072791 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:54:31.198282 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 9 00:54:31.211561 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:54:31.214065 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 9 00:54:31.229355 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 9 00:54:31.234284 systemd-udevd[1318]: Using default interface naming scheme 'v255'. Oct 9 00:54:31.249443 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:54:31.260443 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 00:54:31.283307 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1329) Oct 9 00:54:31.283491 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 9 00:54:31.289275 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1329) Oct 9 00:54:31.313284 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1322) Oct 9 00:54:31.328459 systemd-networkd[1327]: lo: Link UP Oct 9 00:54:31.328469 systemd-networkd[1327]: lo: Gained carrier Oct 9 00:54:31.330963 systemd-networkd[1327]: Enumeration completed Oct 9 00:54:31.332283 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 00:54:31.332938 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:54:31.333007 systemd-networkd[1327]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 00:54:31.333744 systemd[1]: Reached target network.target - Network. Oct 9 00:54:31.334839 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:54:31.334928 systemd-networkd[1327]: eth0: Link UP Oct 9 00:54:31.335057 systemd-networkd[1327]: eth0: Gained carrier Oct 9 00:54:31.335108 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:54:31.341405 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 9 00:54:31.368430 systemd-networkd[1327]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 00:54:31.369292 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 9 00:54:31.370300 systemd-timesyncd[1279]: Network configuration changed, trying to establish connection. Oct 9 00:54:32.482608 systemd-timesyncd[1279]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 9 00:54:32.482698 systemd-resolved[1278]: Clock change detected. Flushing caches. Oct 9 00:54:32.482771 systemd-timesyncd[1279]: Initial clock synchronization to Wed 2024-10-09 00:54:32.482362 UTC. Oct 9 00:54:32.485805 kernel: ACPI: button: Power Button [PWRF] Oct 9 00:54:32.497736 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Oct 9 00:54:32.500721 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:54:32.504852 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 9 00:54:32.505100 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Oct 9 00:54:32.505280 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Oct 9 00:54:32.511933 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 9 00:54:32.525994 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 9 00:54:32.532727 kernel: mousedev: PS/2 mouse device common for all mice Oct 9 00:54:32.540913 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:54:32.644030 kernel: kvm_amd: TSC scaling supported Oct 9 00:54:32.644103 kernel: kvm_amd: Nested Virtualization enabled Oct 9 00:54:32.644117 kernel: kvm_amd: Nested Paging enabled Oct 9 00:54:32.645136 kernel: kvm_amd: LBR virtualization supported Oct 9 00:54:32.645912 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Oct 9 00:54:32.646000 kernel: kvm_amd: Virtual GIF supported Oct 9 00:54:32.665762 kernel: EDAC MC: Ver: 3.0.0 Oct 9 00:54:32.735434 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 9 00:54:32.737396 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:54:32.750846 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 9 00:54:32.760303 lvm[1365]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:54:32.792803 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 9 00:54:32.794383 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:54:32.795496 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:54:32.796695 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 9 00:54:32.797997 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 9 00:54:32.799455 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 9 00:54:32.800667 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 9 00:54:32.801917 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 9 00:54:32.803150 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 00:54:32.803178 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:54:32.804077 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:54:32.805730 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 9 00:54:32.815731 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 9 00:54:32.816810 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:54:32.817786 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:54:32.818750 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:54:32.818787 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:54:32.820260 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 9 00:54:32.822104 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 00:54:32.824043 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 00:54:32.825099 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). Oct 9 00:54:32.826873 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 9 00:54:32.831263 jq[1369]: false Oct 9 00:54:32.832251 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 00:54:32.839020 lvm[1371]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:54:32.839060 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 00:54:32.842096 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 9 00:54:32.845159 extend-filesystems[1370]: Found sr0 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda1 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda2 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda3 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found usr Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda4 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda6 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda7 Oct 9 00:54:32.846103 extend-filesystems[1370]: Found vda9 Oct 9 00:54:32.846103 extend-filesystems[1370]: Checking size of /dev/vda9 Oct 9 00:54:32.849799 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 9 00:54:32.854233 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 9 00:54:32.854756 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 9 00:54:32.855838 dbus-daemon[1368]: [system] SELinux support is enabled Oct 9 00:54:32.859398 systemd[1]: Starting update-engine.service - Update Engine... Oct 9 00:54:32.863841 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 9 00:54:32.865926 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 9 00:54:32.868967 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 00:54:32.869380 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 00:54:32.870579 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:54:32.870800 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 00:54:32.872203 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:54:32.873162 jq[1385]: true Oct 9 00:54:32.872385 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 00:54:32.876934 extend-filesystems[1370]: Old size kept for /dev/vda9 Oct 9 00:54:32.877617 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:54:32.877879 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 00:54:32.880504 update_engine[1381]: I20241009 00:54:32.880209 1381 main.cc:92] Flatcar Update Engine starting Oct 9 00:54:32.880454 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 9 00:54:32.882735 update_engine[1381]: I20241009 00:54:32.881656 1381 update_check_scheduler.cc:74] Next update check in 3m56s Oct 9 00:54:32.890102 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1324) Oct 9 00:54:32.890144 jq[1391]: true Oct 9 00:54:32.900799 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). Oct 9 00:54:32.900821 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 9 00:54:32.903835 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). Oct 9 00:54:32.903853 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 9 00:54:32.905240 systemd[1]: Started update-engine.service - Update Engine. Oct 9 00:54:32.914843 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 9 00:54:32.930448 systemd-logind[1377]: Watching system buttons on /dev/input/event1 (Power Button) Oct 9 00:54:32.930475 systemd-logind[1377]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 9 00:54:32.933848 systemd-logind[1377]: New seat seat0. Oct 9 00:54:32.934987 systemd[1]: Started systemd-logind.service - User Login Management. Oct 9 00:54:32.941959 bash[1415]: Updated "/home/core/.ssh/authorized_keys" Oct 9 00:54:32.944096 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 9 00:54:32.946073 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 00:54:32.949774 locksmithd[1408]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 9 00:54:33.087935 sshd_keygen[1389]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 9 00:54:33.115658 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 9 00:54:33.131915 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 00:54:33.140231 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:54:33.140441 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 00:54:33.143040 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 9 00:54:33.160845 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 9 00:54:33.164368 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 9 00:54:33.166624 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 9 00:54:33.167908 systemd[1]: Reached target getty.target - Login Prompts. Oct 9 00:54:33.627003 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 9 00:54:33.629387 systemd[1]: Started sshd@0-10.0.0.19:22-10.0.0.1:44104.service - OpenSSH per-connection server daemon (10.0.0.1:44104). Oct 9 00:54:33.681351 sshd[1438]: Accepted publickey for core from 10.0.0.1 port 44104 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:33.683460 sshd[1438]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:33.693565 systemd-logind[1377]: New session 1 of user core. Oct 9 00:54:33.695285 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 9 00:54:33.712961 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 9 00:54:33.730427 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 9 00:54:33.741193 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 9 00:54:33.746232 (systemd)[1442]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:54:33.859293 systemd[1442]: Queued start job for default target default.target. Oct 9 00:54:33.869027 systemd[1442]: Created slice app.slice - User Application Slice. Oct 9 00:54:33.869053 systemd[1442]: Reached target paths.target - Paths. Oct 9 00:54:33.869066 systemd[1442]: Reached target timers.target - Timers. Oct 9 00:54:33.870795 systemd[1442]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 9 00:54:33.882519 systemd[1442]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 9 00:54:33.882685 systemd[1442]: Reached target sockets.target - Sockets. Oct 9 00:54:33.882721 systemd[1442]: Reached target basic.target - Basic System. Oct 9 00:54:33.882777 systemd[1442]: Reached target default.target - Main User Target. Oct 9 00:54:33.882818 systemd[1442]: Startup finished in 127ms. Oct 9 00:54:33.883228 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 9 00:54:33.886019 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 9 00:54:33.929879 systemd-networkd[1327]: eth0: Gained IPv6LL Oct 9 00:54:33.934322 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 9 00:54:33.947634 systemd[1]: Reached target network-online.target - Network is Online. Oct 9 00:54:33.955977 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 00:54:33.958360 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 9 00:54:33.960735 systemd[1]: Started sshd@1-10.0.0.19:22-10.0.0.1:44118.service - OpenSSH per-connection server daemon (10.0.0.1:44118). Oct 9 00:54:33.984495 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 9 00:54:33.986132 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 00:54:33.986333 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 00:54:33.989629 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 9 00:54:33.989798 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 00:54:33.991323 systemd[1]: Startup finished in 765ms (kernel) + 3.822s (initrd) + 3.400s (userspace) = 7.988s. Oct 9 00:54:34.001260 sshd[1456]: Accepted publickey for core from 10.0.0.1 port 44118 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.001851 sshd[1456]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.012343 systemd-logind[1377]: New session 2 of user core. Oct 9 00:54:34.014465 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 9 00:54:34.067988 sshd[1456]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.081263 systemd[1]: sshd@1-10.0.0.19:22-10.0.0.1:44118.service: Deactivated successfully. Oct 9 00:54:34.083008 systemd[1]: session-2.scope: Deactivated successfully. Oct 9 00:54:34.084382 systemd-logind[1377]: Session 2 logged out. Waiting for processes to exit. Oct 9 00:54:34.085588 systemd[1]: Started sshd@2-10.0.0.19:22-10.0.0.1:44122.service - OpenSSH per-connection server daemon (10.0.0.1:44122). Oct 9 00:54:34.086293 systemd-logind[1377]: Removed session 2. Oct 9 00:54:34.123490 sshd[1478]: Accepted publickey for core from 10.0.0.1 port 44122 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.124951 sshd[1478]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.129381 systemd-logind[1377]: New session 3 of user core. Oct 9 00:54:34.142946 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 9 00:54:34.193031 sshd[1478]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.210311 systemd[1]: sshd@2-10.0.0.19:22-10.0.0.1:44122.service: Deactivated successfully. Oct 9 00:54:34.212118 systemd[1]: session-3.scope: Deactivated successfully. Oct 9 00:54:34.213541 systemd-logind[1377]: Session 3 logged out. Waiting for processes to exit. Oct 9 00:54:34.214787 systemd[1]: Started sshd@3-10.0.0.19:22-10.0.0.1:44138.service - OpenSSH per-connection server daemon (10.0.0.1:44138). Oct 9 00:54:34.215505 systemd-logind[1377]: Removed session 3. Oct 9 00:54:34.252627 sshd[1485]: Accepted publickey for core from 10.0.0.1 port 44138 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.254201 sshd[1485]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.257892 systemd-logind[1377]: New session 4 of user core. Oct 9 00:54:34.274056 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 9 00:54:34.329719 sshd[1485]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.346375 systemd[1]: sshd@3-10.0.0.19:22-10.0.0.1:44138.service: Deactivated successfully. Oct 9 00:54:34.347945 systemd[1]: session-4.scope: Deactivated successfully. Oct 9 00:54:34.349483 systemd-logind[1377]: Session 4 logged out. Waiting for processes to exit. Oct 9 00:54:34.350731 systemd[1]: Started sshd@4-10.0.0.19:22-10.0.0.1:44140.service - OpenSSH per-connection server daemon (10.0.0.1:44140). Oct 9 00:54:34.351402 systemd-logind[1377]: Removed session 4. Oct 9 00:54:34.390247 sshd[1492]: Accepted publickey for core from 10.0.0.1 port 44140 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.391881 sshd[1492]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.395685 systemd-logind[1377]: New session 5 of user core. Oct 9 00:54:34.409814 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 9 00:54:34.467397 sudo[1495]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 9 00:54:34.467736 sudo[1495]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:34.493314 sudo[1495]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:34.495682 sshd[1492]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.521516 systemd[1]: sshd@4-10.0.0.19:22-10.0.0.1:44140.service: Deactivated successfully. Oct 9 00:54:34.523150 systemd[1]: session-5.scope: Deactivated successfully. Oct 9 00:54:34.524609 systemd-logind[1377]: Session 5 logged out. Waiting for processes to exit. Oct 9 00:54:34.534920 systemd[1]: Started sshd@5-10.0.0.19:22-10.0.0.1:44142.service - OpenSSH per-connection server daemon (10.0.0.1:44142). Oct 9 00:54:34.535645 systemd-logind[1377]: Removed session 5. Oct 9 00:54:34.570883 sshd[1500]: Accepted publickey for core from 10.0.0.1 port 44142 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.572682 sshd[1500]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.576275 systemd-logind[1377]: New session 6 of user core. Oct 9 00:54:34.583834 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 9 00:54:34.636302 sudo[1504]: 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 Oct 9 00:54:34.636606 sudo[1504]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:34.640383 sudo[1504]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:34.646268 sudo[1503]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 9 00:54:34.646565 sudo[1503]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:34.664967 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:54:34.692029 augenrules[1526]: No rules Oct 9 00:54:34.693691 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:54:34.693938 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:54:34.695051 sudo[1503]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:34.696768 sshd[1500]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.708353 systemd[1]: sshd@5-10.0.0.19:22-10.0.0.1:44142.service: Deactivated successfully. Oct 9 00:54:34.709904 systemd[1]: session-6.scope: Deactivated successfully. Oct 9 00:54:34.711129 systemd-logind[1377]: Session 6 logged out. Waiting for processes to exit. Oct 9 00:54:34.712279 systemd[1]: Started sshd@6-10.0.0.19:22-10.0.0.1:44146.service - OpenSSH per-connection server daemon (10.0.0.1:44146). Oct 9 00:54:34.713027 systemd-logind[1377]: Removed session 6. Oct 9 00:54:34.749504 sshd[1534]: Accepted publickey for core from 10.0.0.1 port 44146 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.750754 sshd[1534]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.754198 systemd-logind[1377]: New session 7 of user core. Oct 9 00:54:34.772868 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 9 00:54:34.822057 sshd[1534]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:34.836179 systemd[1]: sshd@6-10.0.0.19:22-10.0.0.1:44146.service: Deactivated successfully. Oct 9 00:54:34.838131 systemd[1]: session-7.scope: Deactivated successfully. Oct 9 00:54:34.840071 systemd-logind[1377]: Session 7 logged out. Waiting for processes to exit. Oct 9 00:54:34.855959 systemd[1]: Started sshd@7-10.0.0.19:22-10.0.0.1:44156.service - OpenSSH per-connection server daemon (10.0.0.1:44156). Oct 9 00:54:34.856899 systemd-logind[1377]: Removed session 7. Oct 9 00:54:34.888058 sshd[1542]: Accepted publickey for core from 10.0.0.1 port 44156 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:34.889333 sshd[1542]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:34.892925 systemd-logind[1377]: New session 8 of user core. Oct 9 00:54:34.905806 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 9 00:54:35.474724 sshd[1542]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:35.489201 systemd[1]: sshd@7-10.0.0.19:22-10.0.0.1:44156.service: Deactivated successfully. Oct 9 00:54:35.490741 systemd[1]: session-8.scope: Deactivated successfully. Oct 9 00:54:35.492454 systemd-logind[1377]: Session 8 logged out. Waiting for processes to exit. Oct 9 00:54:35.501044 systemd[1]: Started sshd@8-10.0.0.19:22-10.0.0.1:57248.service - OpenSSH per-connection server daemon (10.0.0.1:57248). Oct 9 00:54:35.501927 systemd-logind[1377]: Removed session 8. Oct 9 00:54:35.534633 sshd[1559]: Accepted publickey for core from 10.0.0.1 port 57248 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:35.536162 sshd[1559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:35.540097 systemd-logind[1377]: New session 9 of user core. Oct 9 00:54:35.549840 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 9 00:54:40.614922 sudo[1563]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ Oct 9 00:54:40.615236 sudo[1563]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:40.931507 sudo[1563]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:40.933597 sshd[1559]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:40.943511 systemd[1]: sshd@8-10.0.0.19:22-10.0.0.1:57248.service: Deactivated successfully. Oct 9 00:54:40.945281 systemd[1]: session-9.scope: Deactivated successfully. Oct 9 00:54:40.945456 systemd[1]: session-9.scope: Consumed 5.161s CPU time. Oct 9 00:54:40.947121 systemd-logind[1377]: Session 9 logged out. Waiting for processes to exit. Oct 9 00:54:40.958995 systemd[1]: Started sshd@9-10.0.0.19:22-10.0.0.1:57256.service - OpenSSH per-connection server daemon (10.0.0.1:57256). Oct 9 00:54:40.959978 systemd-logind[1377]: Removed session 9. Oct 9 00:54:40.992456 sshd[1621]: Accepted publickey for core from 10.0.0.1 port 57256 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:40.994061 sshd[1621]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:40.999084 systemd-logind[1377]: New session 10 of user core. Oct 9 00:54:41.010870 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 9 00:54:41.065808 sudo[1624]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext Oct 9 00:54:41.066128 sudo[1624]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:41.075427 systemd[1]: ensure-sysext.service: Deactivated successfully. Oct 9 00:54:41.075745 systemd[1]: Stopped ensure-sysext.service. Oct 9 00:54:41.075838 systemd[1]: Stopping ensure-sysext.service... Oct 9 00:54:41.091025 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:54:41.097135 systemd[1]: systemd-sysext.service: Deactivated successfully. Oct 9 00:54:41.097442 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:54:41.100102 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:54:41.111744 kernel: loop0: detected capacity change from 0 to 322896 Oct 9 00:54:41.118735 kernel: EXT4-fs (loop0): mounted filesystem 17bd67ac-35ae-482f-983e-5268c3be6346 ro without journal. Quota mode: none. Oct 9 00:54:41.121727 kernel: EXT4-fs (loop0): unmounting filesystem 17bd67ac-35ae-482f-983e-5268c3be6346. Oct 9 00:54:41.156737 kernel: loop1: detected capacity change from 0 to 301320 Oct 9 00:54:41.162733 kernel: EXT4-fs (loop1): mounted filesystem e29d5ff5-f49e-4451-8434-795c28a937ea ro without journal. Quota mode: none. Oct 9 00:54:41.165725 kernel: EXT4-fs (loop1): unmounting filesystem e29d5ff5-f49e-4451-8434-795c28a937ea. Oct 9 00:54:41.203737 kernel: loop2: detected capacity change from 0 to 322896 Oct 9 00:54:41.209731 kernel: EXT4-fs (loop2): mounted filesystem 17bd67ac-35ae-482f-983e-5268c3be6346 ro without journal. Quota mode: none. Oct 9 00:54:41.210724 kernel: loop3: detected capacity change from 0 to 301320 Oct 9 00:54:41.215470 (sd-merge)[1635]: Using extensions 'containerd', 'docker'. Oct 9 00:54:41.215794 kernel: EXT4-fs (loop3): mounted filesystem e29d5ff5-f49e-4451-8434-795c28a937ea ro without journal. Quota mode: none. Oct 9 00:54:41.216007 (sd-merge)[1635]: Merged extensions into '/usr'. Oct 9 00:54:41.219216 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:54:41.220848 sudo[1624]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:41.222848 sshd[1621]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:41.227917 systemd[1]: Starting ensure-sysext.service... Oct 9 00:54:41.228283 systemd[1]: sshd@9-10.0.0.19:22-10.0.0.1:57256.service: Deactivated successfully. Oct 9 00:54:41.230109 systemd[1]: session-10.scope: Deactivated successfully. Oct 9 00:54:41.230806 systemd-logind[1377]: Session 10 logged out. Waiting for processes to exit. Oct 9 00:54:41.260983 systemd[1]: Started sshd@10-10.0.0.19:22-10.0.0.1:57258.service - OpenSSH per-connection server daemon (10.0.0.1:57258). Oct 9 00:54:41.261462 systemd-logind[1377]: Removed session 10. Oct 9 00:54:41.261463 systemd[1]: Reloading requested from client PID 1639 ('systemctl') (unit ensure-sysext.service)... Oct 9 00:54:41.261475 systemd[1]: Reloading... Oct 9 00:54:41.333002 zram_generator::config[1687]: No configuration found. Oct 9 00:54:41.534285 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. Oct 9 00:54:41.611376 systemd[1]: Reloading finished in 349 ms. Oct 9 00:54:41.679002 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 00:54:41.680834 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 00:54:41.681474 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 00:54:41.682548 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 00:54:41.682568 systemd[1]: Stopping sockets.target - Socket Units... Oct 9 00:54:41.682665 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:54:41.684020 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 00:54:41.684045 systemd[1]: Stopping timers.target - Timer Units... Oct 9 00:54:41.684121 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:54:41.687188 systemd[1]: Stopped target multi-user.target - Multi-User System. Oct 9 00:54:41.687208 systemd[1]: Stopping multi-user.target - Multi-User System... Oct 9 00:54:41.687274 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 00:54:41.689275 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:54:41.690561 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 00:54:41.691877 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 00:54:41.696051 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 00:54:41.699018 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 00:54:41.702025 jq[1722]: false Oct 9 00:54:41.702167 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 00:54:41.707244 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 00:54:41.707602 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 00:54:41.707853 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 9 00:54:41.713933 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 00:54:41.714223 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 00:54:41.717467 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:54:41.717839 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 00:54:41.727278 systemd[1]: Finished ensure-sysext.service. Oct 9 00:54:41.727994 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:54:41.728326 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 00:54:41.732764 extend-filesystems[1723]: Found loop2 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found loop3 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found sr0 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda1 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda2 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda3 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found usr Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda4 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda6 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda7 Oct 9 00:54:41.732764 extend-filesystems[1723]: Found vda9 Oct 9 00:54:41.732764 extend-filesystems[1723]: Checking size of /dev/vda9 Oct 9 00:54:41.734667 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 00:54:41.742553 augenrules[1720]: /sbin/augenrules: No change Oct 9 00:54:41.745040 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:54:41.745294 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 00:54:41.749651 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 00:54:41.750170 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 00:54:41.750804 extend-filesystems[1723]: Old size kept for /dev/vda9 Oct 9 00:54:41.751097 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:54:41.751992 augenrules[1767]: No rules Oct 9 00:54:41.752612 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:54:41.752878 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:54:41.753348 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:54:41.753572 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 00:54:41.756300 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 00:54:41.762759 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1772) Oct 9 00:54:41.818529 containerd[1750]: time="2024-10-09T00:54:41.817621134Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 Oct 9 00:54:41.835309 containerd[1750]: time="2024-10-09T00:54:41.835241999Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 00:54:41.835516 containerd[1750]: time="2024-10-09T00:54:41.835487159Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838001 containerd[1750]: time="2024-10-09T00:54:41.837542253Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838001 containerd[1750]: time="2024-10-09T00:54:41.837992728Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838313 containerd[1750]: time="2024-10-09T00:54:41.838280287Z" 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 Oct 9 00:54:41.838313 containerd[1750]: time="2024-10-09T00:54:41.838307268Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838355 containerd[1750]: time="2024-10-09T00:54:41.838323909Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 9 00:54:41.838355 containerd[1750]: time="2024-10-09T00:54:41.838336903Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838471 containerd[1750]: time="2024-10-09T00:54:41.838443994Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.838883 containerd[1750]: time="2024-10-09T00:54:41.838853081Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:41.839077 containerd[1750]: time="2024-10-09T00:54:41.839047796Z" 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 Oct 9 00:54:41.839077 containerd[1750]: time="2024-10-09T00:54:41.839072723Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 00:54:41.839177 containerd[1750]: time="2024-10-09T00:54:41.839151371Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 9 00:54:41.839211 containerd[1750]: time="2024-10-09T00:54:41.839181136Z" level=info msg="metadata content store policy set" policy=shared Oct 9 00:54:41.845788 containerd[1750]: time="2024-10-09T00:54:41.845743914Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.845979496Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.846020112Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.846063032Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.846092828Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.846114329Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846284 containerd[1750]: time="2024-10-09T00:54:41.846166326Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846742 containerd[1750]: time="2024-10-09T00:54:41.846567969Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846742 containerd[1750]: time="2024-10-09T00:54:41.846620718Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846742 containerd[1750]: time="2024-10-09T00:54:41.846667546Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846832 containerd[1750]: time="2024-10-09T00:54:41.846688035Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.846861 containerd[1750]: time="2024-10-09T00:54:41.846846101Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 00:54:41.847021 containerd[1750]: time="2024-10-09T00:54:41.847000521Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 00:54:41.847112 containerd[1750]: time="2024-10-09T00:54:41.847098615Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 00:54:41.847736 containerd[1750]: time="2024-10-09T00:54:41.847670467Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 00:54:41.847763 containerd[1750]: time="2024-10-09T00:54:41.847747702Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.847783 containerd[1750]: time="2024-10-09T00:54:41.847769252Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 00:54:41.848138 containerd[1750]: time="2024-10-09T00:54:41.848119629Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848165 containerd[1750]: time="2024-10-09T00:54:41.848140889Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848165 containerd[1750]: time="2024-10-09T00:54:41.848154374Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848165906Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848178149Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848191364Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848206362Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848221060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848257 containerd[1750]: time="2024-10-09T00:54:41.848235547Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 00:54:41.848500 containerd[1750]: time="2024-10-09T00:54:41.848477871Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848524 containerd[1750]: time="2024-10-09T00:54:41.848503910Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848524 containerd[1750]: time="2024-10-09T00:54:41.848518998Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848560 containerd[1750]: time="2024-10-09T00:54:41.848531371Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 00:54:41.848560 containerd[1750]: time="2024-10-09T00:54:41.848547782Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Oct 9 00:54:41.848604 containerd[1750]: time="2024-10-09T00:54:41.848559063Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 00:54:41.848604 containerd[1750]: time="2024-10-09T00:54:41.848587948Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Oct 9 00:54:41.848651 containerd[1750]: time="2024-10-09T00:54:41.848622302Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 00:54:41.848888 containerd[1750]: time="2024-10-09T00:54:41.848842154Z" 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}" Oct 9 00:54:41.849034 containerd[1750]: time="2024-10-09T00:54:41.848895805Z" level=info msg="Connect containerd service" Oct 9 00:54:41.849034 containerd[1750]: time="2024-10-09T00:54:41.848937693Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 00:54:41.849819 containerd[1750]: time="2024-10-09T00:54:41.849789341Z" 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" Oct 9 00:54:41.850420 containerd[1750]: time="2024-10-09T00:54:41.850355703Z" level=info msg="Start subscribing containerd event" Oct 9 00:54:41.850443 containerd[1750]: time="2024-10-09T00:54:41.850418751Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 00:54:41.850464 containerd[1750]: time="2024-10-09T00:54:41.850442966Z" level=info msg="Start recovering state" Oct 9 00:54:41.850498 containerd[1750]: time="2024-10-09T00:54:41.850469646Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 00:54:41.850498 containerd[1750]: time="2024-10-09T00:54:41.850484164Z" level=info msg="containerd successfully booted in 0.034630s" Oct 9 00:54:41.850729 containerd[1750]: time="2024-10-09T00:54:41.850689499Z" level=info msg="Start event monitor" Oct 9 00:54:41.850754 containerd[1750]: time="2024-10-09T00:54:41.850727720Z" level=info msg="Start snapshots syncer" Oct 9 00:54:41.850754 containerd[1750]: time="2024-10-09T00:54:41.850742188Z" level=info msg="Start cni network conf syncer for default" Oct 9 00:54:41.850754 containerd[1750]: time="2024-10-09T00:54:41.850751555Z" level=info msg="Start streaming server" Oct 9 00:54:41.861964 sshd[1643]: Accepted publickey for core from 10.0.0.1 port 57258 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:41.863464 sshd[1643]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:41.868743 systemd-logind[1377]: New session 11 of user core. Oct 9 00:54:41.890849 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 9 00:54:42.005911 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 9 00:54:42.006214 (dockerd)[1797]: 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 Oct 9 00:54:42.198670 dockerd[1797]: time="2024-10-09T00:54:42.198587482Z" level=info msg="Starting up" Oct 9 00:54:42.204058 dockerd[1797]: time="2024-10-09T00:54:42.204015541Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 9 00:54:42.204058 dockerd[1797]: time="2024-10-09T00:54:42.204040167Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 9 00:54:42.204249 dockerd[1797]: time="2024-10-09T00:54:42.204204255Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Oct 9 00:54:42.204291 dockerd[1797]: time="2024-10-09T00:54:42.204248167Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 9 00:54:42.209807 dockerd[1797]: time="2024-10-09T00:54:42.209776996Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 9 00:54:42.209807 dockerd[1797]: time="2024-10-09T00:54:42.209798186Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 9 00:54:42.209904 dockerd[1797]: time="2024-10-09T00:54:42.209817051Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Oct 9 00:54:42.209904 dockerd[1797]: time="2024-10-09T00:54:42.209827080Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 9 00:54:42.483031 dockerd[1797]: time="2024-10-09T00:54:42.482903796Z" level=info msg="Loading containers: start." Oct 9 00:54:42.597751 kernel: Initializing XFRM netlink socket Oct 9 00:54:42.619639 dockerd[1797]: time="2024-10-09T00:54:42.619579201Z" 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" Oct 9 00:54:42.675607 systemd-networkd[1327]: docker0: Link UP Oct 9 00:54:42.696279 dockerd[1797]: time="2024-10-09T00:54:42.696232914Z" level=info msg="Loading containers: done." Oct 9 00:54:42.731129 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4203823877-merged.mount: Deactivated successfully. Oct 9 00:54:42.734815 dockerd[1797]: time="2024-10-09T00:54:42.734733276Z" 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 Oct 9 00:54:42.734956 dockerd[1797]: time="2024-10-09T00:54:42.734931678Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 Oct 9 00:54:42.735075 dockerd[1797]: time="2024-10-09T00:54:42.735051844Z" level=info msg="Daemon has completed initialization" Oct 9 00:54:42.758974 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 9 00:54:42.765939 dockerd[1797]: time="2024-10-09T00:54:42.765854139Z" level=info msg="API listen on /run/docker.sock" Oct 9 00:54:44.056034 systemd[1]: var-lib-docker-overlay2-424fb15a1406b597a583d787f964a1fe810fce0e02f123d0a2795c73227042bd\x2dinit-merged.mount: Deactivated successfully. Oct 9 00:54:44.092881 kernel: docker0: port 1(vethb740d60) entered blocking state Oct 9 00:54:44.093022 kernel: docker0: port 1(vethb740d60) entered disabled state Oct 9 00:54:44.093046 kernel: vethb740d60: entered allmulticast mode Oct 9 00:54:44.094010 kernel: vethb740d60: entered promiscuous mode Oct 9 00:54:44.094227 systemd-networkd[1327]: vethb740d60: Link UP Oct 9 00:54:44.160787 containerd[1750]: time="2024-10-09T00:54:44.160675918Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 9 00:54:44.160787 containerd[1750]: time="2024-10-09T00:54:44.160748694Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 9 00:54:44.160787 containerd[1750]: time="2024-10-09T00:54:44.160759855Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 00:54:44.161246 containerd[1750]: time="2024-10-09T00:54:44.161012689Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac pid=1933 runtime=io.containerd.runc.v2 Oct 9 00:54:44.189837 systemd[1]: Started docker-06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac.scope - libcontainer container 06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac. Oct 9 00:54:44.410732 kernel: eth0: renamed from vetha790935 Oct 9 00:54:44.420557 systemd-networkd[1327]: vethb740d60: Gained carrier Oct 9 00:54:44.421374 kernel: docker0: port 1(vethb740d60) entered blocking state Oct 9 00:54:44.421403 kernel: docker0: port 1(vethb740d60) entered forwarding state Oct 9 00:54:44.421148 systemd-networkd[1327]: docker0: Gained carrier Oct 9 00:54:44.424535 systemd-resolved[1278]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 9 00:54:44.454682 systemd[1]: docker-06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac.scope: Deactivated successfully. Oct 9 00:54:44.471832 containerd[1750]: time="2024-10-09T00:54:44.471695300Z" level=info msg="shim disconnected" id=06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac Oct 9 00:54:44.471994 dockerd[1797]: time="2024-10-09T00:54:44.471860380Z" level=info msg="ignoring event" container=06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 9 00:54:44.472395 containerd[1750]: time="2024-10-09T00:54:44.472349527Z" level=warning msg="cleaning up after shim disconnected" id=06beb5ef6629cd20c02b2fe307a808472f43b894d4c4a74fc2e241a9663c5dac namespace=moby Oct 9 00:54:44.472395 containerd[1750]: time="2024-10-09T00:54:44.472376979Z" level=info msg="cleaning up dead shim" Oct 9 00:54:44.480436 containerd[1750]: time="2024-10-09T00:54:44.480379025Z" level=warning msg="cleanup warnings time=\"2024-10-09T00:54:44Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1989 runtime=io.containerd.runc.v2\n" Oct 9 00:54:44.487235 systemd-networkd[1327]: vethb740d60: Lost carrier Oct 9 00:54:44.487720 kernel: docker0: port 1(vethb740d60) entered disabled state Oct 9 00:54:44.487776 kernel: vetha790935: renamed from eth0 Oct 9 00:54:44.504031 systemd-networkd[1327]: vethb740d60: Link DOWN Oct 9 00:54:44.504738 kernel: docker0: port 1(vethb740d60) entered disabled state Oct 9 00:54:44.507186 kernel: vethb740d60 (unregistering): left allmulticast mode Oct 9 00:54:44.507232 kernel: vethb740d60 (unregistering): left promiscuous mode Oct 9 00:54:44.507253 kernel: docker0: port 1(vethb740d60) entered disabled state Oct 9 00:54:44.548623 sshd[1643]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:44.561044 systemd[1]: sshd@10-10.0.0.19:22-10.0.0.1:57258.service: Deactivated successfully. Oct 9 00:54:44.562638 systemd[1]: session-11.scope: Deactivated successfully. Oct 9 00:54:44.563289 systemd-logind[1377]: Session 11 logged out. Waiting for processes to exit. Oct 9 00:54:44.565830 systemd[1]: Started sshd@11-10.0.0.19:22-10.0.0.1:57268.service - OpenSSH per-connection server daemon (10.0.0.1:57268). Oct 9 00:54:44.566312 systemd-logind[1377]: Removed session 11. Oct 9 00:54:44.621323 sshd[2008]: Accepted publickey for core from 10.0.0.1 port 57268 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:44.622982 sshd[2008]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:44.627514 systemd-logind[1377]: New session 12 of user core. Oct 9 00:54:44.636871 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 9 00:54:44.711976 sshd[2008]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:44.721751 systemd[1]: sshd@11-10.0.0.19:22-10.0.0.1:57268.service: Deactivated successfully. Oct 9 00:54:44.723807 systemd[1]: session-12.scope: Deactivated successfully. Oct 9 00:54:44.724495 systemd-logind[1377]: Session 12 logged out. Waiting for processes to exit. Oct 9 00:54:44.744141 systemd[1]: Started sshd@12-10.0.0.19:22-10.0.0.1:57276.service - OpenSSH per-connection server daemon (10.0.0.1:57276). Oct 9 00:54:44.744868 systemd-logind[1377]: Removed session 12. Oct 9 00:54:44.780397 sshd[2018]: Accepted publickey for core from 10.0.0.1 port 57276 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:44.782234 sshd[2018]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:44.787014 systemd-logind[1377]: New session 13 of user core. Oct 9 00:54:44.800934 systemd[1]: Started session-13.scope - Session 13 of User core. Oct 9 00:54:45.068341 systemd[1]: var-lib-docker-overlay2-424fb15a1406b597a583d787f964a1fe810fce0e02f123d0a2795c73227042bd-merged.mount: Deactivated successfully. Oct 9 00:54:45.130100 systemd-networkd[1327]: docker0: Lost carrier Oct 9 00:54:45.577932 systemd-networkd[1327]: docker0: Gained IPv6LL Oct 9 00:54:51.777248 sudo[2021]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ Oct 9 00:54:51.777625 sudo[2021]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:52.107654 sudo[2021]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:52.109696 sshd[2018]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:52.127434 systemd[1]: sshd@12-10.0.0.19:22-10.0.0.1:57276.service: Deactivated successfully. Oct 9 00:54:52.129006 systemd[1]: session-13.scope: Deactivated successfully. Oct 9 00:54:52.129189 systemd[1]: session-13.scope: Consumed 7.274s CPU time. Oct 9 00:54:52.130511 systemd-logind[1377]: Session 13 logged out. Waiting for processes to exit. Oct 9 00:54:52.131691 systemd[1]: Started sshd@13-10.0.0.19:22-10.0.0.1:37474.service - OpenSSH per-connection server daemon (10.0.0.1:37474). Oct 9 00:54:52.132389 systemd-logind[1377]: Removed session 13. Oct 9 00:54:52.171053 sshd[2078]: Accepted publickey for core from 10.0.0.1 port 37474 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:52.173211 sshd[2078]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:52.177422 systemd-logind[1377]: New session 14 of user core. Oct 9 00:54:52.183888 systemd[1]: Started session-14.scope - Session 14 of User core. Oct 9 00:54:52.238909 sudo[2082]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext Oct 9 00:54:52.239267 sudo[2082]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:52.248807 systemd[1]: ensure-sysext.service: Deactivated successfully. Oct 9 00:54:52.249030 systemd[1]: Stopped ensure-sysext.service. Oct 9 00:54:52.249095 systemd[1]: Stopping ensure-sysext.service... Oct 9 00:54:52.263018 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:54:52.267658 systemd-sysext[2084]: Unmerged '/usr'. Oct 9 00:54:52.274268 systemd[1]: systemd-sysext.service: Deactivated successfully. Oct 9 00:54:52.274556 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:54:52.288194 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:54:52.294730 kernel: loop4: detected capacity change from 0 to 301304 Oct 9 00:54:52.301727 kernel: EXT4-fs (loop4): mounted filesystem 118dc3c1-134a-452e-a544-10ff3dbdf1e0 ro without journal. Quota mode: none. Oct 9 00:54:52.304725 kernel: EXT4-fs (loop4): unmounting filesystem 118dc3c1-134a-452e-a544-10ff3dbdf1e0. Oct 9 00:54:52.341733 kernel: loop5: detected capacity change from 0 to 333736 Oct 9 00:54:52.347722 kernel: EXT4-fs (loop5): mounted filesystem 18b05aeb-7f32-4685-8634-bf79113885de ro without journal. Quota mode: none. Oct 9 00:54:52.351735 kernel: EXT4-fs (loop5): unmounting filesystem 18b05aeb-7f32-4685-8634-bf79113885de. Oct 9 00:54:52.371741 kernel: loop6: detected capacity change from 0 to 301304 Oct 9 00:54:52.378741 kernel: EXT4-fs (loop6): mounted filesystem 118dc3c1-134a-452e-a544-10ff3dbdf1e0 ro without journal. Quota mode: none. Oct 9 00:54:52.380726 kernel: loop7: detected capacity change from 0 to 333736 Oct 9 00:54:52.386454 (sd-merge)[2093]: Using extensions 'containerd', 'docker'. Oct 9 00:54:52.386818 kernel: EXT4-fs (loop7): mounted filesystem 18b05aeb-7f32-4685-8634-bf79113885de ro without journal. Quota mode: none. Oct 9 00:54:52.387133 (sd-merge)[2093]: Merged extensions into '/usr'. Oct 9 00:54:52.391217 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:54:52.393159 sudo[2082]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:52.401068 sudo[2081]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart docker containerd Oct 9 00:54:52.401430 sudo[2081]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:54:52.405072 systemd[1]: Starting ensure-sysext.service... Oct 9 00:54:52.412318 systemd[1]: Reloading requested from client PID 2097 ('systemctl') (unit ensure-sysext.service)... Oct 9 00:54:52.412342 systemd[1]: Reloading... Oct 9 00:54:52.502777 zram_generator::config[2140]: No configuration found. Oct 9 00:54:52.725235 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. Oct 9 00:54:52.812770 systemd[1]: Reloading finished in 399 ms. Oct 9 00:54:52.872073 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 00:54:52.872098 systemd[1]: Stopping sockets.target - Socket Units... Oct 9 00:54:52.872253 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 00:54:52.872268 systemd[1]: Stopping timers.target - Timer Units... Oct 9 00:54:52.872438 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:54:52.872948 dockerd[1797]: time="2024-10-09T00:54:52.872901240Z" level=info msg="Processing signal 'terminated'" Oct 9 00:54:52.872973 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 9 00:54:52.873574 dockerd[1797]: time="2024-10-09T00:54:52.873552822Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Oct 9 00:54:52.873782 dockerd[1797]: time="2024-10-09T00:54:52.873764679Z" level=info msg="Daemon shutdown complete" Oct 9 00:54:52.876307 systemd[1]: Stopped target multi-user.target - Multi-User System. Oct 9 00:54:52.876325 systemd[1]: Stopping multi-user.target - Multi-User System... Oct 9 00:54:52.876363 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 00:54:52.885242 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:54:52.886962 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 00:54:52.888430 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 00:54:52.892159 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 00:54:52.896161 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 00:54:52.898189 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 00:54:52.900230 jq[2176]: false Oct 9 00:54:52.901281 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 00:54:52.901580 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 00:54:52.902411 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 9 00:54:52.904914 augenrules[2174]: /sbin/augenrules: No change Oct 9 00:54:52.906358 systemd[1]: docker.service: Deactivated successfully. Oct 9 00:54:52.906733 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 9 00:54:52.910391 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 00:54:52.910949 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 00:54:52.912305 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:54:52.912605 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 00:54:52.914501 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:54:52.914911 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 00:54:52.919011 systemd[1]: Finished ensure-sysext.service. Oct 9 00:54:52.919539 extend-filesystems[2178]: Found loop2 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found loop3 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found loop6 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found loop7 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found sr0 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda1 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda2 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda3 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found usr Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda4 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda6 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda7 Oct 9 00:54:52.919539 extend-filesystems[2178]: Found vda9 Oct 9 00:54:52.919539 extend-filesystems[2178]: Checking size of /dev/vda9 Oct 9 00:54:52.933042 extend-filesystems[2178]: Old size kept for /dev/vda9 Oct 9 00:54:52.934423 augenrules[2210]: No rules Oct 9 00:54:52.936583 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:54:52.936836 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:54:52.937451 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:54:52.937672 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 00:54:52.938338 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:54:52.938562 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 00:54:52.939450 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 00:54:52.939666 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 00:54:52.948636 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2214) Oct 9 00:54:52.970263 systemd[1]: docker.socket: Deactivated successfully. Oct 9 00:54:52.970637 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 9 00:54:52.970689 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 9 00:54:52.973007 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 00:54:52.979218 containerd[1750]: time="2024-10-09T00:54:52.979062571Z" level=info msg="Stop CRI service" Oct 9 00:54:52.979120 systemd[1]: Stopping containerd.service - containerd container runtime... Oct 9 00:54:52.979213 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:54:52.983958 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 00:54:52.986870 systemd[1]: containerd.service: Deactivated successfully. Oct 9 00:54:52.987171 systemd[1]: Stopped containerd.service - containerd container runtime. Oct 9 00:54:52.988743 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:54:52.997968 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 00:54:53.011345 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 00:54:53.012097 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 00:54:53.013589 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 9 00:54:53.019555 (dockerd)[2237]: 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 Oct 9 00:54:53.068615 containerd[2236]: time="2024-10-09T00:54:53.068499206Z" level=info msg="starting containerd" revision=472731909fa34bd7bc9c087e4c27943f9835f111 version=v1.7.21 Oct 9 00:54:53.093964 containerd[2236]: time="2024-10-09T00:54:53.093883320Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 00:54:53.094007 containerd[2236]: time="2024-10-09T00:54:53.093967629Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 00:54:53.094007 containerd[2236]: time="2024-10-09T00:54:53.094004247Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 00:54:53.094045 containerd[2236]: time="2024-10-09T00:54:53.094018374Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094191 containerd[2236]: time="2024-10-09T00:54:53.094165139Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094191 containerd[2236]: time="2024-10-09T00:54:53.094182211Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094191 containerd[2236]: time="2024-10-09T00:54:53.094196758Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094281 containerd[2236]: time="2024-10-09T00:54:53.094206567Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094281 containerd[2236]: time="2024-10-09T00:54:53.094234008Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.094473 containerd[2236]: time="2024-10-09T00:54:53.094356378Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.096644 containerd[2236]: time="2024-10-09T00:54:53.096538931Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:54:53.096644 containerd[2236]: time="2024-10-09T00:54:53.096594906Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:54:53.096857 containerd[2236]: time="2024-10-09T00:54:53.096833182Z" 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 Oct 9 00:54:53.096857 containerd[2236]: time="2024-10-09T00:54:53.096855043Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 00:54:53.096912 containerd[2236]: time="2024-10-09T00:54:53.096888677Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 00:54:53.096912 containerd[2236]: time="2024-10-09T00:54:53.096906871Z" level=info msg="metadata content store policy set" policy=shared Oct 9 00:54:53.097748 containerd[2236]: time="2024-10-09T00:54:53.097670493Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 00:54:53.097748 containerd[2236]: time="2024-10-09T00:54:53.097746766Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 00:54:53.098074 containerd[2236]: time="2024-10-09T00:54:53.097767465Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 00:54:53.098074 containerd[2236]: time="2024-10-09T00:54:53.097792181Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 00:54:53.098074 containerd[2236]: time="2024-10-09T00:54:53.097809473Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 00:54:53.098074 containerd[2236]: time="2024-10-09T00:54:53.097859577Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 00:54:53.098626 containerd[2236]: time="2024-10-09T00:54:53.098599184Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 00:54:53.098769 containerd[2236]: time="2024-10-09T00:54:53.098745589Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 00:54:53.098769 containerd[2236]: time="2024-10-09T00:54:53.098765266Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 00:54:53.098825 containerd[2236]: time="2024-10-09T00:54:53.098779713Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 00:54:53.098825 containerd[2236]: time="2024-10-09T00:54:53.098794250Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098825 containerd[2236]: time="2024-10-09T00:54:53.098807024Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098825 containerd[2236]: time="2024-10-09T00:54:53.098818656Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098832722Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098847310Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098859382Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098871455Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098882125Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 00:54:53.098901 containerd[2236]: time="2024-10-09T00:54:53.098902824Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.098916870Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.098929544Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.098950032Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.098971252Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.098988785Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099001930Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099014613Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099027918Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099042766Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099053466Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099065860Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099076960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099089 containerd[2236]: time="2024-10-09T00:54:53.099090836Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 00:54:53.099337 containerd[2236]: time="2024-10-09T00:54:53.099110644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099337 containerd[2236]: time="2024-10-09T00:54:53.099123648Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099337 containerd[2236]: time="2024-10-09T00:54:53.099136171Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 00:54:53.099457 containerd[2236]: time="2024-10-09T00:54:53.099438398Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 00:54:53.099485 containerd[2236]: time="2024-10-09T00:54:53.099464627Z" 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 Oct 9 00:54:53.099485 containerd[2236]: time="2024-10-09T00:54:53.099476029Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 00:54:53.099485 containerd[2236]: time="2024-10-09T00:54:53.099490326Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 00:54:53.099555 containerd[2236]: time="2024-10-09T00:54:53.099500925Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.099555 containerd[2236]: time="2024-10-09T00:54:53.099516635Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 00:54:53.099555 containerd[2236]: time="2024-10-09T00:54:53.099528698Z" level=info msg="NRI interface is disabled by configuration." Oct 9 00:54:53.099555 containerd[2236]: time="2024-10-09T00:54:53.099541261Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 00:54:53.100130 containerd[2236]: time="2024-10-09T00:54:53.100081033Z" 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}" Oct 9 00:54:53.100247 containerd[2236]: time="2024-10-09T00:54:53.100130256Z" level=info msg="Connect containerd service" Oct 9 00:54:53.100247 containerd[2236]: time="2024-10-09T00:54:53.100156014Z" level=info msg="using legacy CRI server" Oct 9 00:54:53.100247 containerd[2236]: time="2024-10-09T00:54:53.100163408Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 00:54:53.100538 containerd[2236]: time="2024-10-09T00:54:53.100513204Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 00:54:53.101158 containerd[2236]: time="2024-10-09T00:54:53.101106076Z" 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" Oct 9 00:54:53.101535 containerd[2236]: time="2024-10-09T00:54:53.101495286Z" level=info msg="Start subscribing containerd event" Oct 9 00:54:53.101565 containerd[2236]: time="2024-10-09T00:54:53.101551551Z" level=info msg="Start recovering state" Oct 9 00:54:53.101630 containerd[2236]: time="2024-10-09T00:54:53.101611163Z" level=info msg="Start event monitor" Oct 9 00:54:53.101630 containerd[2236]: time="2024-10-09T00:54:53.101628125Z" level=info msg="Start snapshots syncer" Oct 9 00:54:53.101670 containerd[2236]: time="2024-10-09T00:54:53.101639286Z" level=info msg="Start cni network conf syncer for default" Oct 9 00:54:53.101670 containerd[2236]: time="2024-10-09T00:54:53.101647792Z" level=info msg="Start streaming server" Oct 9 00:54:53.101925 containerd[2236]: time="2024-10-09T00:54:53.101898251Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 00:54:53.101976 containerd[2236]: time="2024-10-09T00:54:53.101961149Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 00:54:53.101996 containerd[2236]: time="2024-10-09T00:54:53.101982369Z" level=info msg="containerd successfully booted in 0.035063s" Oct 9 00:54:53.291389 dockerd[2237]: time="2024-10-09T00:54:53.291226139Z" level=info msg="Starting up" Oct 9 00:54:53.738332 dockerd[2237]: time="2024-10-09T00:54:53.738282439Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 9 00:54:53.759851 dockerd[2237]: time="2024-10-09T00:54:53.759792828Z" level=info msg="Loading containers: start." Oct 9 00:54:54.118297 dockerd[2237]: time="2024-10-09T00:54:54.118234675Z" 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" Oct 9 00:54:54.183890 dockerd[2237]: time="2024-10-09T00:54:54.183842954Z" level=info msg="Loading containers: done." Oct 9 00:54:54.196147 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2995956476-merged.mount: Deactivated successfully. Oct 9 00:54:54.197285 dockerd[2237]: time="2024-10-09T00:54:54.197249025Z" 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 Oct 9 00:54:54.197415 dockerd[2237]: time="2024-10-09T00:54:54.197364972Z" level=info msg="Docker daemon" commit=8b539b8 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Oct 9 00:54:54.197415 dockerd[2237]: time="2024-10-09T00:54:54.197411981Z" level=info msg="Daemon has completed initialization" Oct 9 00:54:54.227067 dockerd[2237]: time="2024-10-09T00:54:54.227003786Z" level=info msg="API listen on /run/docker.sock" Oct 9 00:54:54.227198 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 9 00:54:54.228481 sudo[2081]: pam_unix(sudo:session): session closed for user root Oct 9 00:54:54.230383 sshd[2078]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:54.241923 systemd-logind[1377]: Session 14 logged out. Waiting for processes to exit. Oct 9 00:54:54.243724 kernel: EXT4-fs (loop3): unmounting filesystem e29d5ff5-f49e-4451-8434-795c28a937ea. Oct 9 00:54:54.253018 systemd[1]: Started sshd@14-10.0.0.19:22-10.0.0.1:37484.service - OpenSSH per-connection server daemon (10.0.0.1:37484). Oct 9 00:54:54.255725 kernel: EXT4-fs (loop2): unmounting filesystem 17bd67ac-35ae-482f-983e-5268c3be6346. Oct 9 00:54:54.286172 sshd[2443]: Accepted publickey for core from 10.0.0.1 port 37484 ssh2: RSA SHA256:KS4HVlwIXjIoLzXqtuCR/CQI5hNukykBIcj/y/M03ug Oct 9 00:54:54.287701 sshd[2443]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:54:54.291573 systemd-logind[1377]: New session 15 of user core. Oct 9 00:54:54.297810 systemd[1]: Started session-15.scope - Session 15 of User core. Oct 9 00:54:54.308717 systemd[1]: sshd@13-10.0.0.19:22-10.0.0.1:37474.service: Deactivated successfully. Oct 9 00:54:54.310737 systemd[1]: session-14.scope: Deactivated successfully. Oct 9 00:54:54.311742 systemd-logind[1377]: Removed session 14. Oct 9 00:54:54.398763 systemd[1]: var-lib-docker-overlay2-6935c1d82931d9b0a58f225223b71ee3cc1897e1a489a95924b52e6c6c11a6b1\x2dinit-merged.mount: Deactivated successfully. Oct 9 00:54:54.429877 kernel: docker0: port 1(veth433e12d) entered blocking state Oct 9 00:54:54.430000 kernel: docker0: port 1(veth433e12d) entered disabled state Oct 9 00:54:54.430028 kernel: veth433e12d: entered allmulticast mode Oct 9 00:54:54.431091 kernel: veth433e12d: entered promiscuous mode Oct 9 00:54:54.431292 systemd-networkd[1327]: veth433e12d: Link UP Oct 9 00:54:54.486562 containerd[2236]: time="2024-10-09T00:54:54.485807124Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 9 00:54:54.486562 containerd[2236]: time="2024-10-09T00:54:54.486552011Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 9 00:54:54.487061 containerd[2236]: time="2024-10-09T00:54:54.486579463Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 00:54:54.487061 containerd[2236]: time="2024-10-09T00:54:54.486918859Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 00:54:54.511838 systemd[1]: Started docker-d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f.scope - libcontainer container d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f. Oct 9 00:54:54.565735 kernel: eth0: renamed from vethad1787f Oct 9 00:54:54.576989 kernel: docker0: port 1(veth433e12d) entered blocking state Oct 9 00:54:54.577118 kernel: docker0: port 1(veth433e12d) entered forwarding state Oct 9 00:54:54.577035 systemd-networkd[1327]: veth433e12d: Gained carrier Oct 9 00:54:54.577369 systemd-networkd[1327]: docker0: Gained carrier Oct 9 00:54:54.581440 systemd-resolved[1278]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 9 00:54:54.607853 systemd[1]: docker-d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f.scope: Deactivated successfully. Oct 9 00:54:54.623254 dockerd[2237]: time="2024-10-09T00:54:54.623180869Z" level=info msg="ignoring event" container=d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 9 00:54:54.623697 containerd[2236]: time="2024-10-09T00:54:54.623492874Z" level=info msg="shim disconnected" id=d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f namespace=moby Oct 9 00:54:54.623697 containerd[2236]: time="2024-10-09T00:54:54.623532028Z" level=warning msg="cleaning up after shim disconnected" id=d39e5ca01bd95f386228041dd8aa64375297439a9ea7f99d48bcafbc8c09a40f namespace=moby Oct 9 00:54:54.623697 containerd[2236]: time="2024-10-09T00:54:54.623544221Z" level=info msg="cleaning up dead shim" namespace=moby Oct 9 00:54:54.644301 systemd-networkd[1327]: veth433e12d: Lost carrier Oct 9 00:54:54.644720 kernel: docker0: port 1(veth433e12d) entered disabled state Oct 9 00:54:54.644764 kernel: vethad1787f: renamed from eth0 Oct 9 00:54:54.671752 systemd-networkd[1327]: veth433e12d: Link DOWN Oct 9 00:54:54.672823 kernel: docker0: port 1(veth433e12d) entered disabled state Oct 9 00:54:54.675233 kernel: veth433e12d (unregistering): left allmulticast mode Oct 9 00:54:54.675276 kernel: veth433e12d (unregistering): left promiscuous mode Oct 9 00:54:54.675297 kernel: docker0: port 1(veth433e12d) entered disabled state Oct 9 00:54:54.709922 sshd[2443]: pam_unix(sshd:session): session closed for user core Oct 9 00:54:54.714469 systemd[1]: sshd@14-10.0.0.19:22-10.0.0.1:37484.service: Deactivated successfully. Oct 9 00:54:54.717490 systemd[1]: session-15.scope: Deactivated successfully. Oct 9 00:54:54.718235 systemd-logind[1377]: Session 15 logged out. Waiting for processes to exit. Oct 9 00:54:54.719388 systemd-logind[1377]: Removed session 15. Oct 9 00:54:55.396958 systemd[1]: var-lib-docker-overlay2-6935c1d82931d9b0a58f225223b71ee3cc1897e1a489a95924b52e6c6c11a6b1-merged.mount: Deactivated successfully. Oct 9 00:54:55.434088 systemd-networkd[1327]: docker0: Lost carrier