Jan 29 12:08:29.085314 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT_DYNAMIC Wed Jan 29 09:36:13 -00 2025 Jan 29 12:08:29.085341 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=519b8fded83181f8e61f734d5291f916d7548bfba9487c78bcb50d002d81719d Jan 29 12:08:29.085351 kernel: BIOS-provided physical RAM map: Jan 29 12:08:29.085358 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jan 29 12:08:29.085365 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jan 29 12:08:29.085375 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jan 29 12:08:29.085384 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable Jan 29 12:08:29.085391 kernel: BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved Jan 29 12:08:29.085398 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jan 29 12:08:29.085405 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jan 29 12:08:29.085413 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable Jan 29 12:08:29.085420 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jan 29 12:08:29.085427 kernel: NX (Execute Disable) protection: active Jan 29 12:08:29.085437 kernel: APIC: Static calls initialized Jan 29 12:08:29.085446 kernel: SMBIOS 3.0.0 present. Jan 29 12:08:29.085454 kernel: DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2 04/01/2014 Jan 29 12:08:29.085462 kernel: Hypervisor detected: KVM Jan 29 12:08:29.085470 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jan 29 12:08:29.085478 kernel: kvm-clock: using sched offset of 3602151852 cycles Jan 29 12:08:29.085488 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jan 29 12:08:29.085497 kernel: tsc: Detected 1996.249 MHz processor Jan 29 12:08:29.085505 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jan 29 12:08:29.085514 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jan 29 12:08:29.085522 kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 Jan 29 12:08:29.085530 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jan 29 12:08:29.085538 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jan 29 12:08:29.085546 kernel: last_pfn = 0xbffdd max_arch_pfn = 0x400000000 Jan 29 12:08:29.085556 kernel: ACPI: Early table checksum verification disabled Jan 29 12:08:29.085564 kernel: ACPI: RSDP 0x00000000000F51E0 000014 (v00 BOCHS ) Jan 29 12:08:29.085572 kernel: ACPI: RSDT 0x00000000BFFE1B65 000030 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 12:08:29.085581 kernel: ACPI: FACP 0x00000000BFFE1A49 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 12:08:29.085589 kernel: ACPI: DSDT 0x00000000BFFE0040 001A09 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 12:08:29.085596 kernel: ACPI: FACS 0x00000000BFFE0000 000040 Jan 29 12:08:29.085604 kernel: ACPI: APIC 0x00000000BFFE1ABD 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 12:08:29.085612 kernel: ACPI: WAET 0x00000000BFFE1B3D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 12:08:29.085620 kernel: ACPI: Reserving FACP table memory at [mem 0xbffe1a49-0xbffe1abc] Jan 29 12:08:29.085631 kernel: ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a48] Jan 29 12:08:29.085639 kernel: ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] Jan 29 12:08:29.085646 kernel: ACPI: Reserving APIC table memory at [mem 0xbffe1abd-0xbffe1b3c] Jan 29 12:08:29.085655 kernel: ACPI: Reserving WAET table memory at [mem 0xbffe1b3d-0xbffe1b64] Jan 29 12:08:29.085666 kernel: No NUMA configuration found Jan 29 12:08:29.085674 kernel: Faking a node at [mem 0x0000000000000000-0x000000013fffffff] Jan 29 12:08:29.085683 kernel: NODE_DATA(0) allocated [mem 0x13fff7000-0x13fffcfff] Jan 29 12:08:29.085693 kernel: Zone ranges: Jan 29 12:08:29.085701 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jan 29 12:08:29.085710 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jan 29 12:08:29.085718 kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] Jan 29 12:08:29.085726 kernel: Movable zone start for each node Jan 29 12:08:29.085734 kernel: Early memory node ranges Jan 29 12:08:29.085743 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jan 29 12:08:29.085751 kernel: node 0: [mem 0x0000000000100000-0x00000000bffdcfff] Jan 29 12:08:29.085761 kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] Jan 29 12:08:29.085770 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] Jan 29 12:08:29.085778 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jan 29 12:08:29.085786 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jan 29 12:08:29.085794 kernel: On node 0, zone Normal: 35 pages in unavailable ranges Jan 29 12:08:29.085803 kernel: ACPI: PM-Timer IO Port: 0x608 Jan 29 12:08:29.085811 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jan 29 12:08:29.085819 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jan 29 12:08:29.085828 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jan 29 12:08:29.085839 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jan 29 12:08:29.085848 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jan 29 12:08:29.085856 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jan 29 12:08:29.085864 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jan 29 12:08:29.085873 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jan 29 12:08:29.085881 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Jan 29 12:08:29.085889 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jan 29 12:08:29.085898 kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices Jan 29 12:08:29.085906 kernel: Booting paravirtualized kernel on KVM Jan 29 12:08:29.085916 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jan 29 12:08:29.085925 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Jan 29 12:08:29.085934 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576 Jan 29 12:08:29.085942 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152 Jan 29 12:08:29.085951 kernel: pcpu-alloc: [0] 0 1 Jan 29 12:08:29.085959 kernel: kvm-guest: PV spinlocks disabled, no host support Jan 29 12:08:29.085969 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=519b8fded83181f8e61f734d5291f916d7548bfba9487c78bcb50d002d81719d Jan 29 12:08:29.085978 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 12:08:29.085988 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 12:08:29.085996 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 12:08:29.086005 kernel: Fallback order for Node 0: 0 Jan 29 12:08:29.086014 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1031901 Jan 29 12:08:29.086022 kernel: Policy zone: Normal Jan 29 12:08:29.086030 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 12:08:29.086039 kernel: software IO TLB: area num 2. Jan 29 12:08:29.086047 kernel: Memory: 3966204K/4193772K available (12288K kernel code, 2301K rwdata, 22736K rodata, 42972K init, 2220K bss, 227308K reserved, 0K cma-reserved) Jan 29 12:08:29.086056 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 29 12:08:29.086067 kernel: ftrace: allocating 37923 entries in 149 pages Jan 29 12:08:29.086075 kernel: ftrace: allocated 149 pages with 4 groups Jan 29 12:08:29.086083 kernel: Dynamic Preempt: voluntary Jan 29 12:08:29.086092 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 12:08:29.086101 kernel: rcu: RCU event tracing is enabled. Jan 29 12:08:29.086109 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 29 12:08:29.086117 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 12:08:29.086126 kernel: Rude variant of Tasks RCU enabled. Jan 29 12:08:29.086134 kernel: Tracing variant of Tasks RCU enabled. Jan 29 12:08:29.086145 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 12:08:29.086153 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 29 12:08:29.086162 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Jan 29 12:08:29.086170 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 12:08:29.086179 kernel: Console: colour VGA+ 80x25 Jan 29 12:08:29.086187 kernel: printk: console [tty0] enabled Jan 29 12:08:29.086195 kernel: printk: console [ttyS0] enabled Jan 29 12:08:29.086204 kernel: ACPI: Core revision 20230628 Jan 29 12:08:29.086212 kernel: APIC: Switch to symmetric I/O mode setup Jan 29 12:08:29.086222 kernel: x2apic enabled Jan 29 12:08:29.086230 kernel: APIC: Switched APIC routing to: physical x2apic Jan 29 12:08:29.086239 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jan 29 12:08:29.088764 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Jan 29 12:08:29.088775 kernel: Calibrating delay loop (skipped) preset value.. 3992.49 BogoMIPS (lpj=1996249) Jan 29 12:08:29.088783 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jan 29 12:08:29.088792 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jan 29 12:08:29.088800 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jan 29 12:08:29.088810 kernel: Spectre V2 : Mitigation: Retpolines Jan 29 12:08:29.088823 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jan 29 12:08:29.088831 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Jan 29 12:08:29.088840 kernel: Speculative Store Bypass: Vulnerable Jan 29 12:08:29.088848 kernel: x86/fpu: x87 FPU will use FXSAVE Jan 29 12:08:29.088857 kernel: Freeing SMP alternatives memory: 32K Jan 29 12:08:29.088872 kernel: pid_max: default: 32768 minimum: 301 Jan 29 12:08:29.088883 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 12:08:29.088892 kernel: landlock: Up and running. Jan 29 12:08:29.088900 kernel: SELinux: Initializing. Jan 29 12:08:29.088909 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 12:08:29.088918 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 12:08:29.088927 kernel: smpboot: CPU0: AMD Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3) Jan 29 12:08:29.088939 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 12:08:29.088948 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 12:08:29.088957 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 12:08:29.088966 kernel: Performance Events: AMD PMU driver. Jan 29 12:08:29.088976 kernel: ... version: 0 Jan 29 12:08:29.088985 kernel: ... bit width: 48 Jan 29 12:08:29.088994 kernel: ... generic registers: 4 Jan 29 12:08:29.089003 kernel: ... value mask: 0000ffffffffffff Jan 29 12:08:29.089012 kernel: ... max period: 00007fffffffffff Jan 29 12:08:29.089020 kernel: ... fixed-purpose events: 0 Jan 29 12:08:29.089029 kernel: ... event mask: 000000000000000f Jan 29 12:08:29.089038 kernel: signal: max sigframe size: 1440 Jan 29 12:08:29.089047 kernel: rcu: Hierarchical SRCU implementation. Jan 29 12:08:29.089056 kernel: rcu: Max phase no-delay instances is 400. Jan 29 12:08:29.089066 kernel: smp: Bringing up secondary CPUs ... Jan 29 12:08:29.089075 kernel: smpboot: x86: Booting SMP configuration: Jan 29 12:08:29.089084 kernel: .... node #0, CPUs: #1 Jan 29 12:08:29.089093 kernel: smp: Brought up 1 node, 2 CPUs Jan 29 12:08:29.089101 kernel: smpboot: Max logical packages: 2 Jan 29 12:08:29.089110 kernel: smpboot: Total of 2 processors activated (7984.99 BogoMIPS) Jan 29 12:08:29.089119 kernel: devtmpfs: initialized Jan 29 12:08:29.089128 kernel: x86/mm: Memory block size: 128MB Jan 29 12:08:29.089136 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 12:08:29.089147 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 29 12:08:29.089156 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 12:08:29.089165 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 12:08:29.089174 kernel: audit: initializing netlink subsys (disabled) Jan 29 12:08:29.089183 kernel: audit: type=2000 audit(1738152508.293:1): state=initialized audit_enabled=0 res=1 Jan 29 12:08:29.089192 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 12:08:29.089201 kernel: thermal_sys: Registered thermal governor 'user_space' Jan 29 12:08:29.089211 kernel: cpuidle: using governor menu Jan 29 12:08:29.089220 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 12:08:29.089233 kernel: dca service started, version 1.12.1 Jan 29 12:08:29.089261 kernel: PCI: Using configuration type 1 for base access Jan 29 12:08:29.089276 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jan 29 12:08:29.089291 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 12:08:29.089303 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 12:08:29.089315 kernel: ACPI: Added _OSI(Module Device) Jan 29 12:08:29.089329 kernel: ACPI: Added _OSI(Processor Device) Jan 29 12:08:29.089338 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 12:08:29.089347 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 12:08:29.089360 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 12:08:29.089368 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jan 29 12:08:29.089377 kernel: ACPI: Interpreter enabled Jan 29 12:08:29.089386 kernel: ACPI: PM: (supports S0 S3 S5) Jan 29 12:08:29.089395 kernel: ACPI: Using IOAPIC for interrupt routing Jan 29 12:08:29.089405 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jan 29 12:08:29.089414 kernel: PCI: Using E820 reservations for host bridge windows Jan 29 12:08:29.089422 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Jan 29 12:08:29.089431 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 29 12:08:29.089577 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Jan 29 12:08:29.089691 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Jan 29 12:08:29.089796 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Jan 29 12:08:29.089810 kernel: acpiphp: Slot [3] registered Jan 29 12:08:29.089821 kernel: acpiphp: Slot [4] registered Jan 29 12:08:29.089830 kernel: acpiphp: Slot [5] registered Jan 29 12:08:29.089840 kernel: acpiphp: Slot [6] registered Jan 29 12:08:29.089853 kernel: acpiphp: Slot [7] registered Jan 29 12:08:29.089863 kernel: acpiphp: Slot [8] registered Jan 29 12:08:29.089872 kernel: acpiphp: Slot [9] registered Jan 29 12:08:29.089881 kernel: acpiphp: Slot [10] registered Jan 29 12:08:29.089890 kernel: acpiphp: Slot [11] registered Jan 29 12:08:29.089899 kernel: acpiphp: Slot [12] registered Jan 29 12:08:29.089909 kernel: acpiphp: Slot [13] registered Jan 29 12:08:29.089919 kernel: acpiphp: Slot [14] registered Jan 29 12:08:29.089928 kernel: acpiphp: Slot [15] registered Jan 29 12:08:29.089937 kernel: acpiphp: Slot [16] registered Jan 29 12:08:29.089948 kernel: acpiphp: Slot [17] registered Jan 29 12:08:29.089958 kernel: acpiphp: Slot [18] registered Jan 29 12:08:29.089967 kernel: acpiphp: Slot [19] registered Jan 29 12:08:29.089977 kernel: acpiphp: Slot [20] registered Jan 29 12:08:29.089986 kernel: acpiphp: Slot [21] registered Jan 29 12:08:29.089995 kernel: acpiphp: Slot [22] registered Jan 29 12:08:29.090004 kernel: acpiphp: Slot [23] registered Jan 29 12:08:29.090014 kernel: acpiphp: Slot [24] registered Jan 29 12:08:29.090023 kernel: acpiphp: Slot [25] registered Jan 29 12:08:29.090034 kernel: acpiphp: Slot [26] registered Jan 29 12:08:29.090043 kernel: acpiphp: Slot [27] registered Jan 29 12:08:29.090052 kernel: acpiphp: Slot [28] registered Jan 29 12:08:29.090061 kernel: acpiphp: Slot [29] registered Jan 29 12:08:29.090071 kernel: acpiphp: Slot [30] registered Jan 29 12:08:29.090080 kernel: acpiphp: Slot [31] registered Jan 29 12:08:29.090089 kernel: PCI host bridge to bus 0000:00 Jan 29 12:08:29.090190 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jan 29 12:08:29.090333 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jan 29 12:08:29.090435 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jan 29 12:08:29.090544 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jan 29 12:08:29.090630 kernel: pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window] Jan 29 12:08:29.090716 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 29 12:08:29.090831 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Jan 29 12:08:29.090939 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Jan 29 12:08:29.091058 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Jan 29 12:08:29.091158 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] Jan 29 12:08:29.091316 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Jan 29 12:08:29.091423 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Jan 29 12:08:29.091520 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Jan 29 12:08:29.091610 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Jan 29 12:08:29.091706 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Jan 29 12:08:29.091804 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Jan 29 12:08:29.091896 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Jan 29 12:08:29.092002 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000 Jan 29 12:08:29.092101 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfe000000-0xfe7fffff pref] Jan 29 12:08:29.092200 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc000000000-0xc000003fff 64bit pref] Jan 29 12:08:29.092906 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfeb90000-0xfeb90fff] Jan 29 12:08:29.093014 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfeb8ffff pref] Jan 29 12:08:29.093113 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jan 29 12:08:29.093219 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 Jan 29 12:08:29.093350 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc0bf] Jan 29 12:08:29.093447 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfeb91000-0xfeb91fff] Jan 29 12:08:29.093544 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xc000004000-0xc000007fff 64bit pref] Jan 29 12:08:29.093639 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref] Jan 29 12:08:29.093750 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Jan 29 12:08:29.093848 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Jan 29 12:08:29.093946 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfeb92000-0xfeb92fff] Jan 29 12:08:29.094045 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xc000008000-0xc00000bfff 64bit pref] Jan 29 12:08:29.094151 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00 Jan 29 12:08:29.094392 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0c0-0xc0ff] Jan 29 12:08:29.094525 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xc00000c000-0xc00000ffff 64bit pref] Jan 29 12:08:29.094639 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00 Jan 29 12:08:29.094738 kernel: pci 0000:00:06.0: reg 0x10: [io 0xc100-0xc11f] Jan 29 12:08:29.094834 kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfeb93000-0xfeb93fff] Jan 29 12:08:29.094929 kernel: pci 0000:00:06.0: reg 0x20: [mem 0xc000010000-0xc000013fff 64bit pref] Jan 29 12:08:29.094944 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jan 29 12:08:29.094954 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jan 29 12:08:29.094963 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jan 29 12:08:29.094973 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jan 29 12:08:29.094987 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Jan 29 12:08:29.094997 kernel: iommu: Default domain type: Translated Jan 29 12:08:29.095006 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jan 29 12:08:29.095016 kernel: PCI: Using ACPI for IRQ routing Jan 29 12:08:29.095025 kernel: PCI: pci_cache_line_size set to 64 bytes Jan 29 12:08:29.095035 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jan 29 12:08:29.095044 kernel: e820: reserve RAM buffer [mem 0xbffdd000-0xbfffffff] Jan 29 12:08:29.095139 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Jan 29 12:08:29.095236 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Jan 29 12:08:29.098753 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jan 29 12:08:29.098769 kernel: vgaarb: loaded Jan 29 12:08:29.098780 kernel: clocksource: Switched to clocksource kvm-clock Jan 29 12:08:29.098789 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 12:08:29.098799 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 12:08:29.098809 kernel: pnp: PnP ACPI init Jan 29 12:08:29.098909 kernel: pnp 00:03: [dma 2] Jan 29 12:08:29.098925 kernel: pnp: PnP ACPI: found 5 devices Jan 29 12:08:29.098940 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jan 29 12:08:29.098950 kernel: NET: Registered PF_INET protocol family Jan 29 12:08:29.098959 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 12:08:29.098969 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 12:08:29.098979 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 12:08:29.098989 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 12:08:29.098999 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 12:08:29.099009 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 12:08:29.099019 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 12:08:29.099031 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 12:08:29.099041 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 12:08:29.099050 kernel: NET: Registered PF_XDP protocol family Jan 29 12:08:29.099137 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jan 29 12:08:29.101406 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jan 29 12:08:29.101497 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jan 29 12:08:29.101583 kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Jan 29 12:08:29.101667 kernel: pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window] Jan 29 12:08:29.101775 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Jan 29 12:08:29.101876 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Jan 29 12:08:29.101892 kernel: PCI: CLS 0 bytes, default 64 Jan 29 12:08:29.101902 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jan 29 12:08:29.101912 kernel: software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB) Jan 29 12:08:29.101922 kernel: Initialise system trusted keyrings Jan 29 12:08:29.101932 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 12:08:29.101942 kernel: Key type asymmetric registered Jan 29 12:08:29.101955 kernel: Asymmetric key parser 'x509' registered Jan 29 12:08:29.101965 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jan 29 12:08:29.101975 kernel: io scheduler mq-deadline registered Jan 29 12:08:29.101985 kernel: io scheduler kyber registered Jan 29 12:08:29.101995 kernel: io scheduler bfq registered Jan 29 12:08:29.102004 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jan 29 12:08:29.102015 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Jan 29 12:08:29.102025 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Jan 29 12:08:29.102034 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Jan 29 12:08:29.102044 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Jan 29 12:08:29.102056 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 12:08:29.102066 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jan 29 12:08:29.102076 kernel: random: crng init done Jan 29 12:08:29.102086 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jan 29 12:08:29.102096 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jan 29 12:08:29.102105 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jan 29 12:08:29.102209 kernel: rtc_cmos 00:04: RTC can wake from S4 Jan 29 12:08:29.102225 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jan 29 12:08:29.103382 kernel: rtc_cmos 00:04: registered as rtc0 Jan 29 12:08:29.103479 kernel: rtc_cmos 00:04: setting system clock to 2025-01-29T12:08:28 UTC (1738152508) Jan 29 12:08:29.103568 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Jan 29 12:08:29.103582 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jan 29 12:08:29.103592 kernel: NET: Registered PF_INET6 protocol family Jan 29 12:08:29.103602 kernel: Segment Routing with IPv6 Jan 29 12:08:29.103611 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 12:08:29.103621 kernel: NET: Registered PF_PACKET protocol family Jan 29 12:08:29.103635 kernel: Key type dns_resolver registered Jan 29 12:08:29.103645 kernel: IPI shorthand broadcast: enabled Jan 29 12:08:29.103655 kernel: sched_clock: Marking stable (1034007462, 178448518)->(1259977378, -47521398) Jan 29 12:08:29.103664 kernel: registered taskstats version 1 Jan 29 12:08:29.103674 kernel: Loading compiled-in X.509 certificates Jan 29 12:08:29.103683 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: de92a621108c58f5771c86c5c3ccb1aa0728ed55' Jan 29 12:08:29.103693 kernel: Key type .fscrypt registered Jan 29 12:08:29.103702 kernel: Key type fscrypt-provisioning registered Jan 29 12:08:29.103712 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 12:08:29.103723 kernel: ima: Allocated hash algorithm: sha1 Jan 29 12:08:29.103733 kernel: ima: No architecture policies found Jan 29 12:08:29.103742 kernel: clk: Disabling unused clocks Jan 29 12:08:29.103752 kernel: Freeing unused kernel image (initmem) memory: 42972K Jan 29 12:08:29.103762 kernel: Write protecting the kernel read-only data: 36864k Jan 29 12:08:29.103771 kernel: Freeing unused kernel image (rodata/data gap) memory: 1840K Jan 29 12:08:29.103781 kernel: Run /init as init process Jan 29 12:08:29.103790 kernel: with arguments: Jan 29 12:08:29.103799 kernel: /init Jan 29 12:08:29.103810 kernel: with environment: Jan 29 12:08:29.103820 kernel: HOME=/ Jan 29 12:08:29.103829 kernel: TERM=linux Jan 29 12:08:29.103839 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 12:08:29.103851 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 12:08:29.103864 systemd[1]: Detected virtualization kvm. Jan 29 12:08:29.103875 systemd[1]: Detected architecture x86-64. Jan 29 12:08:29.103887 systemd[1]: Running in initrd. Jan 29 12:08:29.103897 systemd[1]: No hostname configured, using default hostname. Jan 29 12:08:29.103907 systemd[1]: Hostname set to . Jan 29 12:08:29.103918 systemd[1]: Initializing machine ID from VM UUID. Jan 29 12:08:29.103928 systemd[1]: Queued start job for default target initrd.target. Jan 29 12:08:29.103938 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 12:08:29.103948 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 12:08:29.103959 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 29 12:08:29.103979 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 12:08:29.103992 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 12:08:29.104002 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 12:08:29.104015 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 29 12:08:29.104025 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 12:08:29.104039 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 12:08:29.104050 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 12:08:29.104060 systemd[1]: Reached target paths.target - Path Units. Jan 29 12:08:29.104071 systemd[1]: Reached target slices.target - Slice Units. Jan 29 12:08:29.104081 systemd[1]: Reached target swap.target - Swaps. Jan 29 12:08:29.104092 systemd[1]: Reached target timers.target - Timer Units. Jan 29 12:08:29.104102 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 12:08:29.104113 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 12:08:29.104123 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 12:08:29.104136 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 12:08:29.104147 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 12:08:29.104158 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 12:08:29.104169 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 12:08:29.104179 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 12:08:29.104190 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 12:08:29.104201 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 12:08:29.104212 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 29 12:08:29.104225 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 12:08:29.104235 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 12:08:29.104262 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 12:08:29.104273 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 12:08:29.104284 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 12:08:29.104316 systemd-journald[185]: Collecting audit messages is disabled. Jan 29 12:08:29.104345 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 12:08:29.104356 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 12:08:29.104372 systemd-journald[185]: Journal started Jan 29 12:08:29.104396 systemd-journald[185]: Runtime Journal (/run/log/journal/1660bc0923d64042a6e4c704b56fef3f) is 8.0M, max 78.3M, 70.3M free. Jan 29 12:08:29.119263 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 12:08:29.120562 systemd-modules-load[186]: Inserted module 'overlay' Jan 29 12:08:29.162229 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 29 12:08:29.162274 kernel: Bridge firewalling registered Jan 29 12:08:29.159544 systemd-modules-load[186]: Inserted module 'br_netfilter' Jan 29 12:08:29.169299 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 12:08:29.170740 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 12:08:29.172520 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:29.174335 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 12:08:29.181490 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 12:08:29.184427 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 12:08:29.185700 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 12:08:29.198505 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 12:08:29.202197 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 12:08:29.207377 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 12:08:29.214586 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 12:08:29.216439 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 12:08:29.219439 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 12:08:29.224409 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 12:08:29.238717 dracut-cmdline[213]: dracut-dracut-053 Jan 29 12:08:29.243274 dracut-cmdline[213]: 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=519b8fded83181f8e61f734d5291f916d7548bfba9487c78bcb50d002d81719d Jan 29 12:08:29.269990 systemd-resolved[219]: Positive Trust Anchors: Jan 29 12:08:29.270809 systemd-resolved[219]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 12:08:29.270858 systemd-resolved[219]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 12:08:29.283398 systemd-resolved[219]: Defaulting to hostname 'linux'. Jan 29 12:08:29.285144 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 12:08:29.286558 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 12:08:29.326276 kernel: SCSI subsystem initialized Jan 29 12:08:29.337360 kernel: Loading iSCSI transport class v2.0-870. Jan 29 12:08:29.350327 kernel: iscsi: registered transport (tcp) Jan 29 12:08:29.373559 kernel: iscsi: registered transport (qla4xxx) Jan 29 12:08:29.373659 kernel: QLogic iSCSI HBA Driver Jan 29 12:08:29.447508 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 12:08:29.455669 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 12:08:29.529785 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 12:08:29.529904 kernel: device-mapper: uevent: version 1.0.3 Jan 29 12:08:29.533526 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 12:08:29.585302 kernel: raid6: sse2x4 gen() 12644 MB/s Jan 29 12:08:29.603308 kernel: raid6: sse2x2 gen() 14707 MB/s Jan 29 12:08:29.621733 kernel: raid6: sse2x1 gen() 9868 MB/s Jan 29 12:08:29.621787 kernel: raid6: using algorithm sse2x2 gen() 14707 MB/s Jan 29 12:08:29.640884 kernel: raid6: .... xor() 9160 MB/s, rmw enabled Jan 29 12:08:29.640944 kernel: raid6: using ssse3x2 recovery algorithm Jan 29 12:08:29.663326 kernel: xor: measuring software checksum speed Jan 29 12:08:29.663400 kernel: prefetch64-sse : 17045 MB/sec Jan 29 12:08:29.666932 kernel: generic_sse : 14379 MB/sec Jan 29 12:08:29.666991 kernel: xor: using function: prefetch64-sse (17045 MB/sec) Jan 29 12:08:29.843303 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 12:08:29.856331 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 12:08:29.864420 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 12:08:29.896090 systemd-udevd[403]: Using default interface naming scheme 'v255'. Jan 29 12:08:29.906984 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 12:08:29.917566 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 12:08:29.949598 dracut-pre-trigger[412]: rd.md=0: removing MD RAID activation Jan 29 12:08:29.988761 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 12:08:29.994483 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 12:08:30.052867 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 12:08:30.062503 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 12:08:30.079398 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 12:08:30.084209 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 12:08:30.086786 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 12:08:30.087363 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 12:08:30.096461 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 12:08:30.115899 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 12:08:30.143295 kernel: virtio_blk virtio2: 2/0/0 default/read/poll queues Jan 29 12:08:30.175501 kernel: virtio_blk virtio2: [vda] 20971520 512-byte logical blocks (10.7 GB/10.0 GiB) Jan 29 12:08:30.175670 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jan 29 12:08:30.175686 kernel: GPT:17805311 != 20971519 Jan 29 12:08:30.175699 kernel: GPT:Alternate GPT header not at the end of the disk. Jan 29 12:08:30.175711 kernel: GPT:17805311 != 20971519 Jan 29 12:08:30.175730 kernel: GPT: Use GNU Parted to correct GPT errors. Jan 29 12:08:30.175742 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 12:08:30.155952 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 12:08:30.156012 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 12:08:30.157585 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 12:08:30.158428 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 12:08:30.158493 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:30.162199 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 12:08:30.176005 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 12:08:30.196282 kernel: libata version 3.00 loaded. Jan 29 12:08:30.204941 kernel: ata_piix 0000:00:01.1: version 2.13 Jan 29 12:08:30.209817 kernel: scsi host0: ata_piix Jan 29 12:08:30.209947 kernel: scsi host1: ata_piix Jan 29 12:08:30.210077 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 Jan 29 12:08:30.210093 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 Jan 29 12:08:30.213270 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (453) Jan 29 12:08:30.228295 kernel: BTRFS: device fsid 5ba3c9ea-61f2-4fe6-a507-2966757f6d44 devid 1 transid 38 /dev/vda3 scanned by (udev-worker) (463) Jan 29 12:08:30.241894 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jan 29 12:08:30.283741 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 12:08:30.285239 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:30.296295 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 29 12:08:30.301593 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 29 12:08:30.302937 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 29 12:08:30.311391 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 12:08:30.315402 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 12:08:30.331410 disk-uuid[505]: Primary Header is updated. Jan 29 12:08:30.331410 disk-uuid[505]: Secondary Entries is updated. Jan 29 12:08:30.331410 disk-uuid[505]: Secondary Header is updated. Jan 29 12:08:30.347845 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 12:08:30.352946 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 12:08:31.364359 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 12:08:31.365310 disk-uuid[506]: The operation has completed successfully. Jan 29 12:08:31.444876 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 12:08:31.444997 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 12:08:31.465375 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 12:08:31.483785 sh[526]: Success Jan 29 12:08:31.514451 kernel: device-mapper: verity: sha256 using implementation "sha256-ssse3" Jan 29 12:08:31.602669 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 12:08:31.615480 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 12:08:31.627667 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 12:08:31.660698 kernel: BTRFS info (device dm-0): first mount of filesystem 5ba3c9ea-61f2-4fe6-a507-2966757f6d44 Jan 29 12:08:31.660790 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jan 29 12:08:31.665297 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 12:08:31.669941 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 12:08:31.673476 kernel: BTRFS info (device dm-0): using free space tree Jan 29 12:08:31.698158 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 12:08:31.700921 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 29 12:08:31.713562 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 29 12:08:31.719708 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 29 12:08:31.742307 kernel: BTRFS info (device vda6): first mount of filesystem 46e45d4d-e07d-4ebc-bafb-221646b0ed58 Jan 29 12:08:31.742417 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 29 12:08:31.743384 kernel: BTRFS info (device vda6): using free space tree Jan 29 12:08:31.757360 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 12:08:31.774298 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 29 12:08:31.780857 kernel: BTRFS info (device vda6): last unmount of filesystem 46e45d4d-e07d-4ebc-bafb-221646b0ed58 Jan 29 12:08:31.797121 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 29 12:08:31.807705 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 29 12:08:31.858572 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 12:08:31.868398 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 12:08:31.893214 systemd-networkd[708]: lo: Link UP Jan 29 12:08:31.893230 systemd-networkd[708]: lo: Gained carrier Jan 29 12:08:31.894492 systemd-networkd[708]: Enumeration completed Jan 29 12:08:31.894884 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 12:08:31.895562 systemd-networkd[708]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 12:08:31.895566 systemd-networkd[708]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 12:08:31.896642 systemd[1]: Reached target network.target - Network. Jan 29 12:08:31.897429 systemd-networkd[708]: eth0: Link UP Jan 29 12:08:31.897433 systemd-networkd[708]: eth0: Gained carrier Jan 29 12:08:31.897444 systemd-networkd[708]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 12:08:31.906319 systemd-networkd[708]: eth0: DHCPv4 address 172.24.4.248/24, gateway 172.24.4.1 acquired from 172.24.4.1 Jan 29 12:08:31.988377 ignition[621]: Ignition 2.20.0 Jan 29 12:08:31.988400 ignition[621]: Stage: fetch-offline Jan 29 12:08:31.988474 ignition[621]: no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:31.988493 ignition[621]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:31.990986 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 12:08:31.988649 ignition[621]: parsed url from cmdline: "" Jan 29 12:08:31.992146 systemd-resolved[219]: Detected conflict on linux IN A 172.24.4.248 Jan 29 12:08:31.988657 ignition[621]: no config URL provided Jan 29 12:08:31.992161 systemd-resolved[219]: Hostname conflict, changing published hostname from 'linux' to 'linux10'. Jan 29 12:08:31.988667 ignition[621]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 12:08:31.988682 ignition[621]: no config at "/usr/lib/ignition/user.ign" Jan 29 12:08:31.988691 ignition[621]: failed to fetch config: resource requires networking Jan 29 12:08:31.988997 ignition[621]: Ignition finished successfully Jan 29 12:08:32.000520 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 29 12:08:32.014901 ignition[717]: Ignition 2.20.0 Jan 29 12:08:32.014914 ignition[717]: Stage: fetch Jan 29 12:08:32.015089 ignition[717]: no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:32.015101 ignition[717]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:32.015194 ignition[717]: parsed url from cmdline: "" Jan 29 12:08:32.015198 ignition[717]: no config URL provided Jan 29 12:08:32.015204 ignition[717]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 12:08:32.015211 ignition[717]: no config at "/usr/lib/ignition/user.ign" Jan 29 12:08:32.015331 ignition[717]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 Jan 29 12:08:32.015357 ignition[717]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... Jan 29 12:08:32.015396 ignition[717]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... Jan 29 12:08:32.388643 ignition[717]: GET result: OK Jan 29 12:08:32.388736 ignition[717]: parsing config with SHA512: b9efeb535ae285bb2b51b452a0770e83aa2a3ed9b3f88b0fb6bd9eb15063efdf844fdaef0f4f7f43e52524e8fc395cece4252eefce6a5750dbae1b8926346f0a Jan 29 12:08:32.397757 unknown[717]: fetched base config from "system" Jan 29 12:08:32.397789 unknown[717]: fetched base config from "system" Jan 29 12:08:32.398146 ignition[717]: fetch: fetch complete Jan 29 12:08:32.397804 unknown[717]: fetched user config from "openstack" Jan 29 12:08:32.398158 ignition[717]: fetch: fetch passed Jan 29 12:08:32.400605 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 29 12:08:32.398287 ignition[717]: Ignition finished successfully Jan 29 12:08:32.409668 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 29 12:08:32.427999 ignition[724]: Ignition 2.20.0 Jan 29 12:08:32.428014 ignition[724]: Stage: kargs Jan 29 12:08:32.428212 ignition[724]: no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:32.432577 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 29 12:08:32.428226 ignition[724]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:32.428848 ignition[724]: kargs: kargs passed Jan 29 12:08:32.428896 ignition[724]: Ignition finished successfully Jan 29 12:08:32.442504 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 29 12:08:32.473419 ignition[730]: Ignition 2.20.0 Jan 29 12:08:32.473438 ignition[730]: Stage: disks Jan 29 12:08:32.473877 ignition[730]: no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:32.473912 ignition[730]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:32.475603 ignition[730]: disks: disks passed Jan 29 12:08:32.477904 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 29 12:08:32.475698 ignition[730]: Ignition finished successfully Jan 29 12:08:32.478975 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 12:08:32.480020 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 12:08:32.482009 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 12:08:32.483796 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 12:08:32.486086 systemd[1]: Reached target basic.target - Basic System. Jan 29 12:08:32.495453 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 12:08:32.522559 systemd-fsck[738]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks Jan 29 12:08:32.534181 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 12:08:32.542387 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 12:08:32.669344 kernel: EXT4-fs (vda9): mounted filesystem 2fbf9359-701e-4995-b3f7-74280bd2b1c9 r/w with ordered data mode. Quota mode: none. Jan 29 12:08:32.670211 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 12:08:32.671632 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 12:08:32.678386 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 12:08:32.682058 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 12:08:32.683760 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 29 12:08:32.685561 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... Jan 29 12:08:32.687987 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 29 12:08:32.688014 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 12:08:32.696094 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 12:08:32.703308 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (746) Jan 29 12:08:32.706949 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 12:08:32.714544 kernel: BTRFS info (device vda6): first mount of filesystem 46e45d4d-e07d-4ebc-bafb-221646b0ed58 Jan 29 12:08:32.714574 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 29 12:08:32.714590 kernel: BTRFS info (device vda6): using free space tree Jan 29 12:08:32.729294 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 12:08:32.735124 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 12:08:32.829974 initrd-setup-root[773]: cut: /sysroot/etc/passwd: No such file or directory Jan 29 12:08:32.838320 initrd-setup-root[781]: cut: /sysroot/etc/group: No such file or directory Jan 29 12:08:32.845096 initrd-setup-root[788]: cut: /sysroot/etc/shadow: No such file or directory Jan 29 12:08:32.854518 initrd-setup-root[795]: cut: /sysroot/etc/gshadow: No such file or directory Jan 29 12:08:32.988782 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 12:08:32.997499 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 29 12:08:33.001801 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 29 12:08:33.009568 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 29 12:08:33.016582 kernel: BTRFS info (device vda6): last unmount of filesystem 46e45d4d-e07d-4ebc-bafb-221646b0ed58 Jan 29 12:08:33.039064 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 29 12:08:33.045465 ignition[864]: INFO : Ignition 2.20.0 Jan 29 12:08:33.046760 ignition[864]: INFO : Stage: mount Jan 29 12:08:33.046760 ignition[864]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:33.046760 ignition[864]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:33.049542 ignition[864]: INFO : mount: mount passed Jan 29 12:08:33.049542 ignition[864]: INFO : Ignition finished successfully Jan 29 12:08:33.048082 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 29 12:08:33.289135 systemd-networkd[708]: eth0: Gained IPv6LL Jan 29 12:08:39.941786 coreos-metadata[748]: Jan 29 12:08:39.941 WARN failed to locate config-drive, using the metadata service API instead Jan 29 12:08:39.982911 coreos-metadata[748]: Jan 29 12:08:39.982 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Jan 29 12:08:39.998586 coreos-metadata[748]: Jan 29 12:08:39.998 INFO Fetch successful Jan 29 12:08:40.000351 coreos-metadata[748]: Jan 29 12:08:40.000 INFO wrote hostname ci-4152-2-0-c-423d66ebd9.novalocal to /sysroot/etc/hostname Jan 29 12:08:40.003019 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. Jan 29 12:08:40.003358 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. Jan 29 12:08:40.016449 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 29 12:08:40.045601 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 12:08:40.077395 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (880) Jan 29 12:08:40.091322 kernel: BTRFS info (device vda6): first mount of filesystem 46e45d4d-e07d-4ebc-bafb-221646b0ed58 Jan 29 12:08:40.091403 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 29 12:08:40.096854 kernel: BTRFS info (device vda6): using free space tree Jan 29 12:08:40.110382 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 12:08:40.118505 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 12:08:40.168848 ignition[898]: INFO : Ignition 2.20.0 Jan 29 12:08:40.168848 ignition[898]: INFO : Stage: files Jan 29 12:08:40.172090 ignition[898]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:40.172090 ignition[898]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:40.172090 ignition[898]: DEBUG : files: compiled without relabeling support, skipping Jan 29 12:08:40.192965 ignition[898]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 29 12:08:40.192965 ignition[898]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 29 12:08:40.207658 ignition[898]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 29 12:08:40.210521 ignition[898]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 29 12:08:40.210521 ignition[898]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 29 12:08:40.208564 unknown[898]: wrote ssh authorized keys file for user: core Jan 29 12:08:40.216615 ignition[898]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 12:08:40.216615 ignition[898]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 12:08:40.216615 ignition[898]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 29 12:08:40.216615 ignition[898]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 29 12:08:40.216615 ignition[898]: INFO : files: files passed Jan 29 12:08:40.216615 ignition[898]: INFO : Ignition finished successfully Jan 29 12:08:40.216426 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 29 12:08:40.226640 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 29 12:08:40.236608 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 12:08:40.247425 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 29 12:08:40.248363 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 29 12:08:40.268369 initrd-setup-root-after-ignition[927]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 12:08:40.268369 initrd-setup-root-after-ignition[927]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 12:08:40.274333 initrd-setup-root-after-ignition[931]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 12:08:40.272399 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 12:08:40.276651 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 29 12:08:40.286534 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 12:08:40.341933 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 12:08:40.342119 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 12:08:40.344953 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 12:08:40.347474 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 12:08:40.350088 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 12:08:40.356563 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 12:08:40.386526 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 12:08:40.395534 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 12:08:40.427620 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 29 12:08:40.429319 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 12:08:40.432216 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 12:08:40.434813 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 12:08:40.435102 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 12:08:40.437828 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 12:08:40.439655 systemd[1]: Stopped target basic.target - Basic System. Jan 29 12:08:40.442092 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 29 12:08:40.444436 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 12:08:40.446828 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 12:08:40.449430 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 12:08:40.451882 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 12:08:40.454531 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 12:08:40.456969 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 12:08:40.459548 systemd[1]: Stopped target swap.target - Swaps. Jan 29 12:08:40.461828 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 12:08:40.462105 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 12:08:40.472141 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 12:08:40.474861 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 12:08:40.477219 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 12:08:40.479547 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 12:08:40.481316 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 12:08:40.481717 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 12:08:40.484559 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 12:08:40.484864 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 12:08:40.487568 systemd[1]: ignition-files.service: Deactivated successfully. Jan 29 12:08:40.487831 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 29 12:08:40.496822 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 29 12:08:40.500742 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 29 12:08:40.504485 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 12:08:40.505561 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 12:08:40.511674 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 12:08:40.512739 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 12:08:40.520996 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 12:08:40.521085 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 12:08:40.533923 ignition[951]: INFO : Ignition 2.20.0 Jan 29 12:08:40.535690 ignition[951]: INFO : Stage: umount Jan 29 12:08:40.535690 ignition[951]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 12:08:40.535690 ignition[951]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 29 12:08:40.535690 ignition[951]: INFO : umount: umount passed Jan 29 12:08:40.535690 ignition[951]: INFO : Ignition finished successfully Jan 29 12:08:40.538430 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 29 12:08:40.539015 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 29 12:08:40.539216 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 29 12:08:40.540720 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 29 12:08:40.540786 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 29 12:08:40.541467 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 29 12:08:40.541509 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 29 12:08:40.544996 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 29 12:08:40.545042 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 29 12:08:40.546031 systemd[1]: Stopped target network.target - Network. Jan 29 12:08:40.547658 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 29 12:08:40.547706 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 12:08:40.549605 systemd[1]: Stopped target paths.target - Path Units. Jan 29 12:08:40.551152 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 12:08:40.553447 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 12:08:40.554071 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 12:08:40.555233 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 12:08:40.556509 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 12:08:40.556548 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 12:08:40.557555 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 12:08:40.557588 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 12:08:40.558587 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 29 12:08:40.558628 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 29 12:08:40.559638 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 12:08:40.559678 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 12:08:40.560795 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 29 12:08:40.561817 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 29 12:08:40.563034 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 29 12:08:40.563123 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 29 12:08:40.564290 systemd-networkd[708]: eth0: DHCPv6 lease lost Jan 29 12:08:40.565093 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 12:08:40.565149 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 12:08:40.566600 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 29 12:08:40.566691 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 29 12:08:40.569391 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 29 12:08:40.569501 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 29 12:08:40.572104 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 29 12:08:40.572416 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 29 12:08:40.577451 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 29 12:08:40.578594 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 29 12:08:40.578666 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 12:08:40.579340 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 12:08:40.579388 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 12:08:40.579943 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 12:08:40.579985 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 12:08:40.580593 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 12:08:40.580636 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 12:08:40.581953 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 12:08:40.595785 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 12:08:40.595931 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 12:08:40.597589 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 29 12:08:40.597684 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 29 12:08:40.599050 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 12:08:40.599107 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 12:08:40.600152 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 12:08:40.600182 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 12:08:40.601372 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 12:08:40.601417 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 12:08:40.603135 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 12:08:40.603178 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 12:08:40.604417 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 12:08:40.604462 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 12:08:40.611468 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 12:08:40.612750 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 12:08:40.612806 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 12:08:40.614137 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 29 12:08:40.614180 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 12:08:40.615781 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 12:08:40.615835 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 12:08:40.619811 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 12:08:40.619855 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:40.621432 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 12:08:40.621516 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 12:08:40.622648 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 12:08:40.637408 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 12:08:40.644534 systemd[1]: Switching root. Jan 29 12:08:40.675697 systemd-journald[185]: Journal stopped Jan 29 12:08:41.910324 systemd-journald[185]: Received SIGTERM from PID 1 (systemd). Jan 29 12:08:41.910396 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 12:08:41.910431 kernel: SELinux: policy capability open_perms=1 Jan 29 12:08:41.910443 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 12:08:41.910464 kernel: SELinux: policy capability always_check_network=0 Jan 29 12:08:41.910475 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 12:08:41.910487 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 12:08:41.910503 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 12:08:41.910514 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 12:08:41.910525 kernel: audit: type=1403 audit(1738152520.871:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 12:08:41.910538 systemd[1]: Successfully loaded SELinux policy in 82.411ms. Jan 29 12:08:41.910561 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 21.019ms. Jan 29 12:08:41.910576 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 12:08:41.910588 systemd[1]: Detected virtualization kvm. Jan 29 12:08:41.910600 systemd[1]: Detected architecture x86-64. Jan 29 12:08:41.910612 systemd[1]: Detected first boot. Jan 29 12:08:41.910623 systemd[1]: Hostname set to . Jan 29 12:08:41.910637 systemd[1]: Initializing machine ID from VM UUID. Jan 29 12:08:41.910649 zram_generator::config[994]: No configuration found. Jan 29 12:08:41.910662 systemd[1]: Populated /etc with preset unit settings. Jan 29 12:08:41.910676 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 12:08:41.910688 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 12:08:41.910700 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 12:08:41.910713 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 12:08:41.910727 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 12:08:41.910741 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 12:08:41.910753 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 12:08:41.910764 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 12:08:41.910777 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 12:08:41.910791 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 12:08:41.910803 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 12:08:41.910816 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 12:08:41.910829 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 12:08:41.910841 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 12:08:41.910856 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 12:08:41.910869 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 12:08:41.910882 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 12:08:41.910894 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jan 29 12:08:41.910999 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 12:08:41.911016 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 12:08:41.911029 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 12:08:41.911049 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 12:08:41.911062 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 12:08:41.911074 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 12:08:41.911087 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 12:08:41.911099 systemd[1]: Reached target slices.target - Slice Units. Jan 29 12:08:41.911112 systemd[1]: Reached target swap.target - Swaps. Jan 29 12:08:41.911125 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 12:08:41.911137 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 12:08:41.911152 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 12:08:41.911165 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 12:08:41.911178 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 12:08:41.911191 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 12:08:41.911203 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 12:08:41.911216 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 12:08:41.911229 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 12:08:41.911258 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:41.911274 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 12:08:41.911290 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 12:08:41.911303 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 12:08:41.911318 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 29 12:08:41.911331 systemd[1]: Reached target machines.target - Containers. Jan 29 12:08:41.911343 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 12:08:41.911357 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 12:08:41.911369 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 12:08:41.911382 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 12:08:41.911395 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 12:08:41.911410 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 12:08:41.911422 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 12:08:41.911436 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 12:08:41.911448 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 12:08:41.911461 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 12:08:41.911474 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 12:08:41.911487 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 12:08:41.911500 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 12:08:41.911515 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 12:08:41.911528 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 12:08:41.911540 kernel: fuse: init (API version 7.39) Jan 29 12:08:41.911552 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 12:08:41.911566 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 12:08:41.911578 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 12:08:41.911592 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 12:08:41.912783 systemd-journald[1080]: Collecting audit messages is disabled. Jan 29 12:08:41.912824 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 12:08:41.912837 systemd[1]: Stopped verity-setup.service. Jan 29 12:08:41.912851 systemd-journald[1080]: Journal started Jan 29 12:08:41.912875 systemd-journald[1080]: Runtime Journal (/run/log/journal/1660bc0923d64042a6e4c704b56fef3f) is 8.0M, max 78.3M, 70.3M free. Jan 29 12:08:41.608870 systemd[1]: Queued start job for default target multi-user.target. Jan 29 12:08:41.632967 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jan 29 12:08:41.633371 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 12:08:41.918298 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:41.926169 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 12:08:41.925461 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 12:08:41.927384 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 12:08:41.927975 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 12:08:41.928551 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 12:08:41.929386 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 12:08:41.932720 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 12:08:41.934015 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 12:08:41.935089 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 12:08:41.935482 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 12:08:41.953475 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 12:08:41.953609 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 12:08:41.954392 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 12:08:41.956087 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 12:08:41.956294 kernel: loop: module loaded Jan 29 12:08:41.958159 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 12:08:41.959410 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 12:08:41.960396 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 12:08:41.960527 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 12:08:41.961266 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 12:08:41.962537 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 12:08:41.964415 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 12:08:41.979466 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 12:08:41.982268 kernel: ACPI: bus type drm_connector registered Jan 29 12:08:41.987338 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 12:08:41.998324 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 12:08:41.998941 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 12:08:41.998981 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 12:08:42.003549 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 12:08:42.008388 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 12:08:42.011523 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 12:08:42.012152 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 12:08:42.015394 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 12:08:42.017419 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 12:08:42.020327 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 12:08:42.021382 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 12:08:42.021973 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 12:08:42.022898 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 12:08:42.025369 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 12:08:42.028429 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 12:08:42.039739 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 12:08:42.041700 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 12:08:42.041839 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 12:08:42.043626 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 12:08:42.044389 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 12:08:42.045401 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 12:08:42.047399 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 12:08:42.062476 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 12:08:42.087340 systemd-journald[1080]: Time spent on flushing to /var/log/journal/1660bc0923d64042a6e4c704b56fef3f is 56.150ms for 925 entries. Jan 29 12:08:42.087340 systemd-journald[1080]: System Journal (/var/log/journal/1660bc0923d64042a6e4c704b56fef3f) is 8.0M, max 584.8M, 576.8M free. Jan 29 12:08:42.184193 kernel: loop0: detected capacity change from 0 to 138184 Jan 29 12:08:42.184236 systemd-journald[1080]: Received client request to flush runtime journal. Jan 29 12:08:42.184304 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 12:08:42.109167 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 12:08:42.111376 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 29 12:08:42.121963 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 29 12:08:42.123303 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 12:08:42.137779 udevadm[1134]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jan 29 12:08:42.142126 systemd-tmpfiles[1126]: ACLs are not supported, ignoring. Jan 29 12:08:42.142140 systemd-tmpfiles[1126]: ACLs are not supported, ignoring. Jan 29 12:08:42.152169 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 12:08:42.158390 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 12:08:42.189546 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 12:08:42.204084 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 29 12:08:42.204675 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 29 12:08:42.219355 kernel: loop1: detected capacity change from 0 to 140992 Jan 29 12:08:42.243093 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 12:08:42.253447 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 12:08:42.274960 systemd-tmpfiles[1150]: ACLs are not supported, ignoring. Jan 29 12:08:42.275497 systemd-tmpfiles[1150]: ACLs are not supported, ignoring. Jan 29 12:08:42.280103 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 12:08:42.285834 kernel: loop2: detected capacity change from 0 to 8 Jan 29 12:08:42.303271 kernel: loop3: detected capacity change from 0 to 138184 Jan 29 12:08:42.337279 kernel: loop4: detected capacity change from 0 to 140992 Jan 29 12:08:42.405289 kernel: loop5: detected capacity change from 0 to 8 Jan 29 12:08:42.406040 (sd-merge)[1155]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'. Jan 29 12:08:42.407450 (sd-merge)[1155]: Merged extensions into '/usr'. Jan 29 12:08:42.413568 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 12:08:42.424411 systemd[1]: Starting ensure-sysext.service... Jan 29 12:08:42.430102 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 12:08:42.440386 systemd[1]: Reloading requested from client PID 1157 ('systemctl') (unit ensure-sysext.service)... Jan 29 12:08:42.440403 systemd[1]: Reloading... Jan 29 12:08:42.466987 systemd-tmpfiles[1158]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 12:08:42.469682 systemd-tmpfiles[1158]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 12:08:42.471705 systemd-tmpfiles[1158]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 12:08:42.472026 systemd-tmpfiles[1158]: ACLs are not supported, ignoring. Jan 29 12:08:42.472087 systemd-tmpfiles[1158]: ACLs are not supported, ignoring. Jan 29 12:08:42.477912 systemd-tmpfiles[1158]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 12:08:42.478041 systemd-tmpfiles[1158]: Skipping /boot Jan 29 12:08:42.502783 systemd-tmpfiles[1158]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 12:08:42.504000 systemd-tmpfiles[1158]: Skipping /boot Jan 29 12:08:42.558282 zram_generator::config[1186]: No configuration found. Jan 29 12:08:42.765477 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 29 12:08:42.822708 systemd[1]: Reloading finished in 381 ms. Jan 29 12:08:42.850301 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 12:08:42.876222 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 12:08:42.881837 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 12:08:42.885489 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 12:08:42.897437 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 12:08:42.904417 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 12:08:42.909411 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.909858 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 12:08:42.915800 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 12:08:42.919118 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 12:08:42.921523 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 12:08:42.923911 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 12:08:42.924065 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.925171 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 12:08:42.925382 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 12:08:42.926330 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 12:08:42.926523 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 12:08:42.930706 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.930889 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 12:08:42.939134 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 12:08:42.942172 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 12:08:42.942969 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 12:08:42.943161 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.944164 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 12:08:42.944403 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 12:08:42.945398 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 12:08:42.945532 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 12:08:42.948508 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 12:08:42.948644 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 12:08:42.960294 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.960571 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 12:08:42.968754 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 12:08:42.977555 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 12:08:42.983364 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 12:08:42.987322 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 12:08:42.988506 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 12:08:42.994932 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 12:08:42.995539 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 29 12:08:42.999173 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 12:08:43.007286 systemd[1]: Finished ensure-sysext.service. Jan 29 12:08:43.014652 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 12:08:43.014778 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 12:08:43.027421 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 29 12:08:43.030281 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 12:08:43.031530 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 12:08:43.031864 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 12:08:43.064135 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 12:08:43.064845 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 12:08:43.066820 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 12:08:43.067371 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 12:08:43.072296 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 12:08:43.073640 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 12:08:43.073714 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 12:08:43.080412 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 12:08:43.085300 augenrules[1290]: No rules Jan 29 12:08:43.085440 ldconfig[1120]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 12:08:43.083539 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 12:08:43.085304 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 12:08:43.098809 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 12:08:43.104856 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 12:08:43.110500 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 12:08:43.149942 systemd-udevd[1292]: Using default interface naming scheme 'v255'. Jan 29 12:08:43.150602 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 12:08:43.154371 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 12:08:43.155106 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 29 12:08:43.182180 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 12:08:43.192427 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 12:08:43.220755 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 29 12:08:43.221448 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 12:08:43.228190 systemd-resolved[1249]: Positive Trust Anchors: Jan 29 12:08:43.228551 systemd-resolved[1249]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 12:08:43.228644 systemd-resolved[1249]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 12:08:43.234795 systemd-resolved[1249]: Using system hostname 'ci-4152-2-0-c-423d66ebd9.novalocal'. Jan 29 12:08:43.236961 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 12:08:43.237621 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 12:08:43.268286 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jan 29 12:08:43.285169 systemd-networkd[1312]: lo: Link UP Jan 29 12:08:43.285179 systemd-networkd[1312]: lo: Gained carrier Jan 29 12:08:43.288521 systemd-networkd[1312]: Enumeration completed Jan 29 12:08:43.288629 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 12:08:43.289334 systemd[1]: Reached target network.target - Network. Jan 29 12:08:43.300342 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 12:08:43.339287 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1330) Jan 29 12:08:43.360289 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jan 29 12:08:43.363342 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Jan 29 12:08:43.374280 kernel: ACPI: button: Power Button [PWRF] Jan 29 12:08:43.392317 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jan 29 12:08:43.425282 kernel: mousedev: PS/2 mouse device common for all mice Jan 29 12:08:43.428283 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0 Jan 29 12:08:43.428335 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console Jan 29 12:08:43.433851 kernel: Console: switching to colour dummy device 80x25 Jan 29 12:08:43.434938 kernel: [drm] features: -virgl +edid -resource_blob -host_visible Jan 29 12:08:43.434970 kernel: [drm] features: -context_init Jan 29 12:08:43.437294 kernel: [drm] number of scanouts: 1 Jan 29 12:08:43.437726 systemd-networkd[1312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 12:08:43.437736 systemd-networkd[1312]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 12:08:43.438357 systemd-networkd[1312]: eth0: Link UP Jan 29 12:08:43.438366 systemd-networkd[1312]: eth0: Gained carrier Jan 29 12:08:43.438379 systemd-networkd[1312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 12:08:43.443294 kernel: [drm] number of cap sets: 0 Jan 29 12:08:43.444827 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 12:08:43.446337 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:02.0 on minor 0 Jan 29 12:08:43.455360 kernel: fbcon: virtio_gpudrmfb (fb0) is primary device Jan 29 12:08:43.455452 kernel: Console: switching to colour frame buffer device 160x50 Jan 29 12:08:43.461374 systemd-networkd[1312]: eth0: DHCPv4 address 172.24.4.248/24, gateway 172.24.4.1 acquired from 172.24.4.1 Jan 29 12:08:43.461504 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 12:08:43.462275 kernel: virtio-pci 0000:00:02.0: [drm] fb0: virtio_gpudrmfb frame buffer device Jan 29 12:08:43.463849 systemd-timesyncd[1280]: Network configuration changed, trying to establish connection. Jan 29 12:08:43.470443 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 12:08:43.484631 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 12:08:43.484907 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 12:08:43.485269 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:43.490427 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 12:08:43.491724 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 12:08:43.492731 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 12:08:43.515086 lvm[1347]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 12:08:43.538461 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 12:08:43.539762 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 12:08:43.542478 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 12:08:43.557081 lvm[1353]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 12:08:43.582976 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 12:08:43.584335 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 12:08:43.585109 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 12:08:43.585353 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 12:08:43.585461 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 29 12:08:43.585704 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 12:08:43.585872 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 12:08:43.585960 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 12:08:43.586033 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 12:08:43.586061 systemd[1]: Reached target paths.target - Path Units. Jan 29 12:08:43.586117 systemd[1]: Reached target timers.target - Timer Units. Jan 29 12:08:43.588235 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 12:08:43.589532 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 12:08:43.595018 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 12:08:43.596215 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 12:08:43.596803 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 12:08:43.598345 systemd[1]: Reached target basic.target - Basic System. Jan 29 12:08:43.600696 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 12:08:43.600799 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 12:08:43.602052 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 12:08:43.609338 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 29 12:08:43.621536 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 12:08:43.633473 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 12:08:43.637713 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 12:08:43.640084 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 29 12:08:43.648601 jq[1365]: false Jan 29 12:08:43.650020 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 12:08:43.661556 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 12:08:43.671479 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 12:08:43.678942 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 12:08:43.681127 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 29 12:08:43.681609 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 12:08:43.685113 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 12:08:43.697987 extend-filesystems[1366]: Found loop3 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found loop4 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found loop5 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda1 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda2 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda3 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found usr Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda4 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda6 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda7 Jan 29 12:08:43.697987 extend-filesystems[1366]: Found vda9 Jan 29 12:08:43.697987 extend-filesystems[1366]: Checking size of /dev/vda9 Jan 29 12:08:43.833885 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1330) Jan 29 12:08:43.833937 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 2014203 blocks Jan 29 12:08:43.698430 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 12:08:43.738722 dbus-daemon[1362]: [system] SELinux support is enabled Jan 29 12:08:43.895887 kernel: EXT4-fs (vda9): resized filesystem to 2014203 Jan 29 12:08:43.895924 extend-filesystems[1366]: Resized partition /dev/vda9 Jan 29 12:08:43.708094 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 12:08:43.897761 extend-filesystems[1395]: resize2fs 1.47.1 (20-May-2024) Jan 29 12:08:43.905510 jq[1379]: true Jan 29 12:08:43.708347 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 12:08:43.905800 update_engine[1378]: I20250129 12:08:43.753919 1378 main.cc:92] Flatcar Update Engine starting Jan 29 12:08:43.905800 update_engine[1378]: I20250129 12:08:43.786907 1378 update_check_scheduler.cc:74] Next update check in 4m40s Jan 29 12:08:43.708659 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 12:08:43.708794 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 12:08:43.712131 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 12:08:43.908548 extend-filesystems[1395]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jan 29 12:08:43.908548 extend-filesystems[1395]: old_desc_blocks = 1, new_desc_blocks = 1 Jan 29 12:08:43.908548 extend-filesystems[1395]: The filesystem on /dev/vda9 is now 2014203 (4k) blocks long. Jan 29 12:08:43.937025 jq[1386]: true Jan 29 12:08:43.712479 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 12:08:43.967489 extend-filesystems[1366]: Resized filesystem in /dev/vda9 Jan 29 12:08:43.739129 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 12:08:43.970949 bash[1412]: Updated "/home/core/.ssh/authorized_keys" Jan 29 12:08:43.762850 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 12:08:43.771072 (ntainerd)[1389]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 12:08:43.779822 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 29 12:08:43.779857 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 12:08:43.790481 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 29 12:08:43.790510 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 12:08:43.793820 systemd[1]: Started update-engine.service - Update Engine. Jan 29 12:08:43.820488 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 12:08:43.853530 systemd-logind[1377]: New seat seat0. Jan 29 12:08:43.903046 systemd-logind[1377]: Watching system buttons on /dev/input/event1 (Power Button) Jan 29 12:08:43.903068 systemd-logind[1377]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jan 29 12:08:43.909345 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 12:08:43.922449 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 12:08:43.922664 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 12:08:43.970010 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 29 12:08:43.980505 systemd[1]: Starting sshkeys.service... Jan 29 12:08:44.023875 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jan 29 12:08:44.035136 locksmithd[1397]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 12:08:44.035703 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jan 29 12:08:44.206235 containerd[1389]: time="2025-01-29T12:08:44.206010569Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 12:08:44.238906 containerd[1389]: time="2025-01-29T12:08:44.238856942Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240426 containerd[1389]: time="2025-01-29T12:08:44.240389086Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240475 containerd[1389]: time="2025-01-29T12:08:44.240424682Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 12:08:44.240475 containerd[1389]: time="2025-01-29T12:08:44.240444189Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 12:08:44.240650 containerd[1389]: time="2025-01-29T12:08:44.240625980Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 12:08:44.240678 containerd[1389]: time="2025-01-29T12:08:44.240656527Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240748 containerd[1389]: time="2025-01-29T12:08:44.240722260Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240748 containerd[1389]: time="2025-01-29T12:08:44.240744011Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240925 containerd[1389]: time="2025-01-29T12:08:44.240898251Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240925 containerd[1389]: time="2025-01-29T12:08:44.240921404Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240971 containerd[1389]: time="2025-01-29T12:08:44.240937234Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 12:08:44.240971 containerd[1389]: time="2025-01-29T12:08:44.240948545Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.241049 containerd[1389]: time="2025-01-29T12:08:44.241025780Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.241265 containerd[1389]: time="2025-01-29T12:08:44.241229782Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 12:08:44.241653 containerd[1389]: time="2025-01-29T12:08:44.241346842Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 12:08:44.241653 containerd[1389]: time="2025-01-29T12:08:44.241368432Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 12:08:44.241653 containerd[1389]: time="2025-01-29T12:08:44.241447671Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 12:08:44.241653 containerd[1389]: time="2025-01-29T12:08:44.241497344Z" level=info msg="metadata content store policy set" policy=shared Jan 29 12:08:44.249100 containerd[1389]: time="2025-01-29T12:08:44.249079064Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 12:08:44.249274 containerd[1389]: time="2025-01-29T12:08:44.249189781Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 12:08:44.249274 containerd[1389]: time="2025-01-29T12:08:44.249213586Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249230317Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249369759Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249480747Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249705378Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249806007Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249824221Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249838778Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249853125Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249867703Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249881208Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249897058Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249912537Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249926192Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251265 containerd[1389]: time="2025-01-29T12:08:44.249939427Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.249952502Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.249972529Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.249986676Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250013917Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250029496Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250044304Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250061296Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250074591Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250089078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250103775Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250120407Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250133852Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250149040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250161894Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251556 containerd[1389]: time="2025-01-29T12:08:44.250178355Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250199896Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250213591Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250225394Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250289424Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250308289Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250319400Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250332555Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250344156Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250358223Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250369233Z" level=info msg="NRI interface is disabled by configuration." Jan 29 12:08:44.251842 containerd[1389]: time="2025-01-29T12:08:44.250379773Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 12:08:44.252053 containerd[1389]: time="2025-01-29T12:08:44.250699443Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 29 12:08:44.252053 containerd[1389]: time="2025-01-29T12:08:44.250755167Z" level=info msg="Connect containerd service" Jan 29 12:08:44.252053 containerd[1389]: time="2025-01-29T12:08:44.250786065Z" level=info msg="using legacy CRI server" Jan 29 12:08:44.252053 containerd[1389]: time="2025-01-29T12:08:44.250793709Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 12:08:44.252053 containerd[1389]: time="2025-01-29T12:08:44.250918844Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 12:08:44.252658 containerd[1389]: time="2025-01-29T12:08:44.252633470Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 29 12:08:44.252981 containerd[1389]: time="2025-01-29T12:08:44.252963238Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 12:08:44.253077 containerd[1389]: time="2025-01-29T12:08:44.253057205Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 12:08:44.253174 containerd[1389]: time="2025-01-29T12:08:44.253138377Z" level=info msg="Start subscribing containerd event" Jan 29 12:08:44.253241 containerd[1389]: time="2025-01-29T12:08:44.253228376Z" level=info msg="Start recovering state" Jan 29 12:08:44.253377 containerd[1389]: time="2025-01-29T12:08:44.253361916Z" level=info msg="Start event monitor" Jan 29 12:08:44.253440 containerd[1389]: time="2025-01-29T12:08:44.253427359Z" level=info msg="Start snapshots syncer" Jan 29 12:08:44.253498 containerd[1389]: time="2025-01-29T12:08:44.253485949Z" level=info msg="Start cni network conf syncer for default" Jan 29 12:08:44.253551 containerd[1389]: time="2025-01-29T12:08:44.253540180Z" level=info msg="Start streaming server" Jan 29 12:08:44.253656 containerd[1389]: time="2025-01-29T12:08:44.253642162Z" level=info msg="containerd successfully booted in 0.048726s" Jan 29 12:08:44.253749 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 12:08:44.429564 sshd_keygen[1388]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 29 12:08:44.468312 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 12:08:44.481773 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 12:08:44.495561 systemd[1]: Started sshd@0-172.24.4.248:22-172.24.4.1:49296.service - OpenSSH per-connection server daemon (172.24.4.1:49296). Jan 29 12:08:44.505487 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 12:08:44.505886 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 12:08:44.517755 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 12:08:44.539096 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 12:08:44.551856 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 12:08:44.563784 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jan 29 12:08:44.569671 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 12:08:44.616651 systemd-networkd[1312]: eth0: Gained IPv6LL Jan 29 12:08:44.617701 systemd-timesyncd[1280]: Network configuration changed, trying to establish connection. Jan 29 12:08:44.620432 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 12:08:44.627979 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 12:08:44.640068 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 12:08:44.686118 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 12:08:45.976790 sshd[1443]: Accepted publickey for core from 172.24.4.1 port 49296 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:08:45.981021 sshd-session[1443]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:08:46.007413 systemd-logind[1377]: New session 1 of user core. Jan 29 12:08:46.012296 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 12:08:46.025048 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 12:08:46.065543 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 12:08:46.079046 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 12:08:46.102647 (systemd)[1464]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 12:08:46.266356 systemd[1464]: Queued start job for default target default.target. Jan 29 12:08:46.277198 systemd[1464]: Created slice app.slice - User Application Slice. Jan 29 12:08:46.277228 systemd[1464]: Reached target paths.target - Paths. Jan 29 12:08:46.277264 systemd[1464]: Reached target timers.target - Timers. Jan 29 12:08:46.278734 systemd[1464]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 12:08:46.308058 systemd[1464]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 12:08:46.308184 systemd[1464]: Reached target sockets.target - Sockets. Jan 29 12:08:46.308200 systemd[1464]: Reached target basic.target - Basic System. Jan 29 12:08:46.308240 systemd[1464]: Reached target default.target - Main User Target. Jan 29 12:08:46.308288 systemd[1464]: Startup finished in 191ms. Jan 29 12:08:46.308401 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 12:08:46.314514 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 12:08:46.765321 systemd[1]: Started sshd@1-172.24.4.248:22-172.24.4.1:44198.service - OpenSSH per-connection server daemon (172.24.4.1:44198). Jan 29 12:08:48.237783 sshd[1476]: Accepted publickey for core from 172.24.4.1 port 44198 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:08:48.240838 sshd-session[1476]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:08:48.251506 systemd-logind[1377]: New session 2 of user core. Jan 29 12:08:48.256559 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 12:08:48.862568 sshd[1479]: Connection closed by 172.24.4.1 port 44198 Jan 29 12:08:48.863634 sshd-session[1476]: pam_unix(sshd:session): session closed for user core Jan 29 12:08:48.875801 systemd[1]: sshd@1-172.24.4.248:22-172.24.4.1:44198.service: Deactivated successfully. Jan 29 12:08:48.878672 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 12:08:48.881789 systemd-logind[1377]: Session 2 logged out. Waiting for processes to exit. Jan 29 12:08:48.887984 systemd[1]: Started sshd@2-172.24.4.248:22-172.24.4.1:44210.service - OpenSSH per-connection server daemon (172.24.4.1:44210). Jan 29 12:08:48.894482 systemd-logind[1377]: Removed session 2. Jan 29 12:08:49.603152 login[1449]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jan 29 12:08:49.616700 systemd-logind[1377]: New session 3 of user core. Jan 29 12:08:49.626230 login[1450]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jan 29 12:08:49.628739 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 12:08:49.641938 systemd-logind[1377]: New session 4 of user core. Jan 29 12:08:49.651682 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 29 12:08:50.035617 sshd[1484]: Accepted publickey for core from 172.24.4.1 port 44210 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:08:50.038319 sshd-session[1484]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:08:50.048414 systemd-logind[1377]: New session 5 of user core. Jan 29 12:08:50.066652 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 29 12:08:50.664479 sshd[1512]: Connection closed by 172.24.4.1 port 44210 Jan 29 12:08:50.665502 sshd-session[1484]: pam_unix(sshd:session): session closed for user core Jan 29 12:08:50.671589 systemd[1]: sshd@2-172.24.4.248:22-172.24.4.1:44210.service: Deactivated successfully. Jan 29 12:08:50.677108 systemd[1]: session-5.scope: Deactivated successfully. Jan 29 12:08:50.681761 systemd-logind[1377]: Session 5 logged out. Waiting for processes to exit. Jan 29 12:08:50.684952 systemd-logind[1377]: Removed session 5. Jan 29 12:08:50.690926 coreos-metadata[1361]: Jan 29 12:08:50.690 WARN failed to locate config-drive, using the metadata service API instead Jan 29 12:08:50.742919 coreos-metadata[1361]: Jan 29 12:08:50.742 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 Jan 29 12:08:50.927883 coreos-metadata[1361]: Jan 29 12:08:50.927 INFO Fetch successful Jan 29 12:08:50.927883 coreos-metadata[1361]: Jan 29 12:08:50.927 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Jan 29 12:08:50.942347 coreos-metadata[1361]: Jan 29 12:08:50.942 INFO Fetch successful Jan 29 12:08:50.942347 coreos-metadata[1361]: Jan 29 12:08:50.942 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 Jan 29 12:08:50.956752 coreos-metadata[1361]: Jan 29 12:08:50.956 INFO Fetch successful Jan 29 12:08:50.956752 coreos-metadata[1361]: Jan 29 12:08:50.956 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 Jan 29 12:08:50.970964 coreos-metadata[1361]: Jan 29 12:08:50.970 INFO Fetch successful Jan 29 12:08:50.970964 coreos-metadata[1361]: Jan 29 12:08:50.970 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 Jan 29 12:08:50.987033 coreos-metadata[1361]: Jan 29 12:08:50.986 INFO Fetch successful Jan 29 12:08:50.987033 coreos-metadata[1361]: Jan 29 12:08:50.986 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 Jan 29 12:08:51.000999 coreos-metadata[1361]: Jan 29 12:08:51.000 INFO Fetch successful Jan 29 12:08:51.051938 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 29 12:08:51.054340 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 29 12:08:51.156896 coreos-metadata[1423]: Jan 29 12:08:51.156 WARN failed to locate config-drive, using the metadata service API instead Jan 29 12:08:51.199413 coreos-metadata[1423]: Jan 29 12:08:51.199 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 Jan 29 12:08:51.214006 coreos-metadata[1423]: Jan 29 12:08:51.213 INFO Fetch successful Jan 29 12:08:51.214006 coreos-metadata[1423]: Jan 29 12:08:51.213 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 Jan 29 12:08:51.229552 coreos-metadata[1423]: Jan 29 12:08:51.229 INFO Fetch successful Jan 29 12:08:51.236779 unknown[1423]: wrote ssh authorized keys file for user: core Jan 29 12:08:51.287443 update-ssh-keys[1525]: Updated "/home/core/.ssh/authorized_keys" Jan 29 12:08:51.288514 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jan 29 12:08:51.292623 systemd[1]: Finished sshkeys.service. Jan 29 12:08:51.296821 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 12:08:51.297122 systemd[1]: Startup finished in 1.248s (kernel) + 12.052s (initrd) + 10.505s (userspace) = 23.806s. Jan 29 12:09:00.693116 systemd[1]: Started sshd@3-172.24.4.248:22-172.24.4.1:59716.service - OpenSSH per-connection server daemon (172.24.4.1:59716). Jan 29 12:09:01.952797 sshd[1530]: Accepted publickey for core from 172.24.4.1 port 59716 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:01.955581 sshd-session[1530]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:01.966413 systemd-logind[1377]: New session 6 of user core. Jan 29 12:09:01.976571 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 29 12:09:02.681543 sshd[1532]: Connection closed by 172.24.4.1 port 59716 Jan 29 12:09:02.682656 sshd-session[1530]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:02.703172 systemd[1]: sshd@3-172.24.4.248:22-172.24.4.1:59716.service: Deactivated successfully. Jan 29 12:09:02.706596 systemd[1]: session-6.scope: Deactivated successfully. Jan 29 12:09:02.709369 systemd-logind[1377]: Session 6 logged out. Waiting for processes to exit. Jan 29 12:09:02.715846 systemd[1]: Started sshd@4-172.24.4.248:22-172.24.4.1:59728.service - OpenSSH per-connection server daemon (172.24.4.1:59728). Jan 29 12:09:02.718626 systemd-logind[1377]: Removed session 6. Jan 29 12:09:04.246820 sshd[1537]: Accepted publickey for core from 172.24.4.1 port 59728 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:04.249551 sshd-session[1537]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:04.259968 systemd-logind[1377]: New session 7 of user core. Jan 29 12:09:04.271534 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 29 12:09:04.893300 sshd[1539]: Connection closed by 172.24.4.1 port 59728 Jan 29 12:09:04.893916 sshd-session[1537]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:04.902215 systemd[1]: sshd@4-172.24.4.248:22-172.24.4.1:59728.service: Deactivated successfully. Jan 29 12:09:04.905410 systemd[1]: session-7.scope: Deactivated successfully. Jan 29 12:09:04.907051 systemd-logind[1377]: Session 7 logged out. Waiting for processes to exit. Jan 29 12:09:04.917896 systemd[1]: Started sshd@5-172.24.4.248:22-172.24.4.1:33246.service - OpenSSH per-connection server daemon (172.24.4.1:33246). Jan 29 12:09:04.919637 systemd-logind[1377]: Removed session 7. Jan 29 12:09:06.295447 sshd[1544]: Accepted publickey for core from 172.24.4.1 port 33246 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:06.298090 sshd-session[1544]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:06.307330 systemd-logind[1377]: New session 8 of user core. Jan 29 12:09:06.318579 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 29 12:09:06.882900 sshd[1546]: Connection closed by 172.24.4.1 port 33246 Jan 29 12:09:06.882740 sshd-session[1544]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:06.896508 systemd[1]: sshd@5-172.24.4.248:22-172.24.4.1:33246.service: Deactivated successfully. Jan 29 12:09:06.899778 systemd[1]: session-8.scope: Deactivated successfully. Jan 29 12:09:06.901543 systemd-logind[1377]: Session 8 logged out. Waiting for processes to exit. Jan 29 12:09:06.913992 systemd[1]: Started sshd@6-172.24.4.248:22-172.24.4.1:33258.service - OpenSSH per-connection server daemon (172.24.4.1:33258). Jan 29 12:09:06.917205 systemd-logind[1377]: Removed session 8. Jan 29 12:09:08.157918 sshd[1551]: Accepted publickey for core from 172.24.4.1 port 33258 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:08.161218 sshd-session[1551]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:08.172011 systemd-logind[1377]: New session 9 of user core. Jan 29 12:09:08.185597 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 29 12:09:08.623755 sudo[1554]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 29 12:09:08.625122 sudo[1554]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:08.644617 sudo[1554]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:08.862713 sshd[1553]: Connection closed by 172.24.4.1 port 33258 Jan 29 12:09:08.864530 sshd-session[1551]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:08.877630 systemd[1]: sshd@6-172.24.4.248:22-172.24.4.1:33258.service: Deactivated successfully. Jan 29 12:09:08.881478 systemd[1]: session-9.scope: Deactivated successfully. Jan 29 12:09:08.885526 systemd-logind[1377]: Session 9 logged out. Waiting for processes to exit. Jan 29 12:09:08.891927 systemd[1]: Started sshd@7-172.24.4.248:22-172.24.4.1:33268.service - OpenSSH per-connection server daemon (172.24.4.1:33268). Jan 29 12:09:08.895016 systemd-logind[1377]: Removed session 9. Jan 29 12:09:10.053941 sshd[1559]: Accepted publickey for core from 172.24.4.1 port 33268 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:10.056640 sshd-session[1559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:10.065980 systemd-logind[1377]: New session 10 of user core. Jan 29 12:09:10.075599 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 29 12:09:10.529235 sudo[1563]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 29 12:09:10.530001 sudo[1563]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:10.537212 sudo[1563]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:10.549981 sudo[1562]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 29 12:09:10.551105 sudo[1562]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:10.575003 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 12:09:10.648752 augenrules[1585]: No rules Jan 29 12:09:10.650978 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 12:09:10.651461 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 12:09:10.653659 sudo[1562]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:10.933190 sshd[1561]: Connection closed by 172.24.4.1 port 33268 Jan 29 12:09:10.934036 sshd-session[1559]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:10.939356 systemd[1]: sshd@7-172.24.4.248:22-172.24.4.1:33268.service: Deactivated successfully. Jan 29 12:09:10.942724 systemd[1]: session-10.scope: Deactivated successfully. Jan 29 12:09:10.945798 systemd-logind[1377]: Session 10 logged out. Waiting for processes to exit. Jan 29 12:09:10.948094 systemd-logind[1377]: Removed session 10. Jan 29 12:09:15.568602 systemd-resolved[1249]: Clock change detected. Flushing caches. Jan 29 12:09:15.568789 systemd-timesyncd[1280]: Contacted time server 82.64.45.50:123 (2.flatcar.pool.ntp.org). Jan 29 12:09:15.568855 systemd-timesyncd[1280]: Initial clock synchronization to Wed 2025-01-29 12:09:15.568490 UTC. Jan 29 12:09:16.104905 systemd[1]: Started sshd@8-172.24.4.248:22-172.24.4.1:54296.service - OpenSSH per-connection server daemon (172.24.4.1:54296). Jan 29 12:09:17.170964 sshd[1593]: Accepted publickey for core from 172.24.4.1 port 54296 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:17.173835 sshd-session[1593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:17.185889 systemd-logind[1377]: New session 11 of user core. Jan 29 12:09:17.191797 systemd[1]: Started session-11.scope - Session 11 of User core. Jan 29 12:09:17.682567 sudo[1600]: core : PWD=/tmp/tmp.dd4wlGsGJU ; USER=root ; COMMAND=/usr/sbin/ldd /usr/bin/nc /usr/bin/timeout Jan 29 12:09:17.683232 sudo[1600]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:17.705978 sudo[1600]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:17.718524 sudo[1612]: core : PWD=/tmp/tmp.dd4wlGsGJU ; USER=root ; COMMAND=/usr/sbin/rsync -av --relative --copy-links /usr/bin/nc /usr/bin/timeout /lib64/ld-linux-x86-64.so.2 /lib64/libbsd.so.0 /lib64/libc.so.6 /lib64/libmd.so.0 /lib64/libresolv.so.2 ./ Jan 29 12:09:17.719160 sudo[1612]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:17.807878 sudo[1612]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:17.819488 sudo[1596]: core : PWD=/tmp/tmp.dd4wlGsGJU ; USER=root ; COMMAND=/usr/sbin/docker build -t netcat . Jan 29 12:09:17.820126 sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:18.153924 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 29 12:09:18.157983 (dockerd)[1623]: 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 Jan 29 12:09:18.696012 dockerd[1623]: time="2025-01-29T12:09:18.695934940Z" level=info msg="Starting up" Jan 29 12:09:19.042493 systemd[1]: var-lib-docker-metacopy\x2dcheck879678949-merged.mount: Deactivated successfully. Jan 29 12:09:19.088813 dockerd[1623]: time="2025-01-29T12:09:19.088776344Z" level=info msg="Loading containers: start." Jan 29 12:09:19.270678 kernel: Initializing XFRM netlink socket Jan 29 12:09:19.357080 systemd-networkd[1312]: docker0: Link UP Jan 29 12:09:19.402904 dockerd[1623]: time="2025-01-29T12:09:19.402758668Z" level=info msg="Loading containers: done." Jan 29 12:09:19.428622 dockerd[1623]: time="2025-01-29T12:09:19.428199011Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Jan 29 12:09:19.428622 dockerd[1623]: time="2025-01-29T12:09:19.428306884Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Jan 29 12:09:19.428622 dockerd[1623]: time="2025-01-29T12:09:19.428418774Z" level=info msg="Daemon has completed initialization" Jan 29 12:09:19.474477 dockerd[1623]: time="2025-01-29T12:09:19.474427824Z" level=info msg="API listen on /run/docker.sock" Jan 29 12:09:19.474872 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 29 12:09:20.458873 systemd[1]: var-lib-docker-tmp-buildkit\x2dmount552254326.mount: Deactivated successfully. Jan 29 12:09:20.575628 sudo[1596]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:20.782429 sshd[1595]: Connection closed by 172.24.4.1 port 54296 Jan 29 12:09:20.783903 sshd-session[1593]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:20.798127 systemd[1]: sshd@8-172.24.4.248:22-172.24.4.1:54296.service: Deactivated successfully. Jan 29 12:09:20.801846 systemd[1]: session-11.scope: Deactivated successfully. Jan 29 12:09:20.813548 systemd-logind[1377]: Session 11 logged out. Waiting for processes to exit. Jan 29 12:09:20.821073 systemd[1]: Started sshd@10-172.24.4.248:22-172.24.4.1:54314.service - OpenSSH per-connection server daemon (172.24.4.1:54314). Jan 29 12:09:20.829029 systemd[1]: Started sshd@9-172.24.4.248:22-172.24.4.1:54308.service - OpenSSH per-connection server daemon (172.24.4.1:54308). Jan 29 12:09:20.835590 systemd-logind[1377]: Removed session 11. Jan 29 12:09:21.951797 sshd[1831]: Accepted publickey for core from 172.24.4.1 port 54308 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:21.954490 sshd-session[1831]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:21.963732 systemd-logind[1377]: New session 12 of user core. Jan 29 12:09:21.972674 systemd[1]: Started session-12.scope - Session 12 of User core. Jan 29 12:09:22.131559 sshd[1830]: Accepted publickey for core from 172.24.4.1 port 54314 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:22.134148 sshd-session[1830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:22.144602 systemd-logind[1377]: New session 13 of user core. Jan 29 12:09:22.153699 systemd[1]: Started session-13.scope - Session 13 of User core. Jan 29 12:09:22.284807 sudo[1837]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/lsof -i TCP:9988 -s TCP:LISTEN Jan 29 12:09:22.285857 sudo[1837]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:22.330649 sudo[1837]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:22.544607 sshd[1834]: Connection closed by 172.24.4.1 port 54308 Jan 29 12:09:22.544211 sshd-session[1831]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:22.551115 systemd[1]: sshd@9-172.24.4.248:22-172.24.4.1:54308.service: Deactivated successfully. Jan 29 12:09:22.554336 systemd[1]: session-12.scope: Deactivated successfully. Jan 29 12:09:22.556065 systemd-logind[1377]: Session 12 logged out. Waiting for processes to exit. Jan 29 12:09:22.559206 systemd-logind[1377]: Removed session 12. Jan 29 12:09:22.663943 systemd[1]: Started sshd@11-172.24.4.248:22-172.24.4.1:54320.service - OpenSSH per-connection server daemon (172.24.4.1:54320). Jan 29 12:09:22.763241 systemd[1]: var-lib-docker-overlay2-ba1cd49b2d04327dafd725c3111c3cc5b7cf22fa40abaeb379bd632b996a22af\x2dinit-merged.mount: Deactivated successfully. Jan 29 12:09:22.860225 kernel: docker0: port 1(veth47f6117) entered blocking state Jan 29 12:09:22.860484 kernel: docker0: port 1(veth47f6117) entered disabled state Jan 29 12:09:22.860546 kernel: veth47f6117: entered allmulticast mode Jan 29 12:09:22.863552 kernel: veth47f6117: entered promiscuous mode Jan 29 12:09:22.864122 systemd-networkd[1312]: veth47f6117: Link UP Jan 29 12:09:23.143030 containerd[1389]: time="2025-01-29T12:09:23.142161317Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 29 12:09:23.143030 containerd[1389]: time="2025-01-29T12:09:23.142363797Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 29 12:09:23.143030 containerd[1389]: time="2025-01-29T12:09:23.142477870Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 12:09:23.144922 containerd[1389]: time="2025-01-29T12:09:23.142666023Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 12:09:23.185566 systemd[1]: Started docker-960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e.scope - libcontainer container 960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e. Jan 29 12:09:23.259448 kernel: eth0: renamed from veth5059373 Jan 29 12:09:23.268284 kernel: docker0: port 1(veth47f6117) entered blocking state Jan 29 12:09:23.268338 kernel: docker0: port 1(veth47f6117) entered forwarding state Jan 29 12:09:23.268294 systemd-networkd[1312]: veth47f6117: Gained carrier Jan 29 12:09:23.269573 systemd-networkd[1312]: docker0: Gained carrier Jan 29 12:09:24.164306 sshd[1843]: Accepted publickey for core from 172.24.4.1 port 54320 ssh2: RSA SHA256:3zxyn8GTxln78fZPvADYDU0Y6VpYL5FrRdlm8jwk4vY Jan 29 12:09:24.167160 sshd-session[1843]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 12:09:24.177743 systemd-logind[1377]: New session 14 of user core. Jan 29 12:09:24.184694 systemd[1]: Started session-14.scope - Session 14 of User core. Jan 29 12:09:24.482710 systemd-networkd[1312]: veth47f6117: Gained IPv6LL Jan 29 12:09:24.640104 sudo[1939]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/lsof -i TCP:9988 -s TCP:LISTEN Jan 29 12:09:24.640826 sudo[1939]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 12:09:24.684242 sudo[1939]: pam_unix(sudo:session): session closed for user root Jan 29 12:09:24.846443 sshd[1937]: Connection closed by 172.24.4.1 port 54320 Jan 29 12:09:24.847549 sshd-session[1843]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:24.853703 systemd-logind[1377]: Session 14 logged out. Waiting for processes to exit. Jan 29 12:09:24.853999 systemd[1]: sshd@11-172.24.4.248:22-172.24.4.1:54320.service: Deactivated successfully. Jan 29 12:09:24.857940 systemd[1]: session-14.scope: Deactivated successfully. Jan 29 12:09:24.861309 systemd-logind[1377]: Removed session 14. Jan 29 12:09:24.930708 systemd-networkd[1312]: docker0: Gained IPv6LL Jan 29 12:09:27.394718 systemd[1]: docker-960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e.scope: Deactivated successfully. Jan 29 12:09:27.428021 dockerd[1623]: time="2025-01-29T12:09:27.427271039Z" level=info msg="ignoring event" container=960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jan 29 12:09:27.428771 containerd[1389]: time="2025-01-29T12:09:27.428684720Z" level=info msg="shim disconnected" id=960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e namespace=moby Jan 29 12:09:27.428771 containerd[1389]: time="2025-01-29T12:09:27.428753960Z" level=warning msg="cleaning up after shim disconnected" id=960e5ac0391e720000a8dd11a752e52cab9375a48d188855d76773ac39ef573e namespace=moby Jan 29 12:09:27.429262 containerd[1389]: time="2025-01-29T12:09:27.428776482Z" level=info msg="cleaning up dead shim" namespace=moby Jan 29 12:09:27.454050 containerd[1389]: time="2025-01-29T12:09:27.453917374Z" level=warning msg="cleanup warnings time=\"2025-01-29T12:09:27Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=moby Jan 29 12:09:27.513602 kernel: docker0: port 1(veth47f6117) entered disabled state Jan 29 12:09:27.513426 systemd-networkd[1312]: veth47f6117: Lost carrier Jan 29 12:09:27.516651 kernel: veth5059373: renamed from eth0 Jan 29 12:09:27.536518 systemd-networkd[1312]: veth47f6117: Link DOWN Jan 29 12:09:27.541450 kernel: docker0: port 1(veth47f6117) entered disabled state Jan 29 12:09:27.550739 kernel: veth47f6117 (unregistering): left allmulticast mode Jan 29 12:09:27.550886 kernel: veth47f6117 (unregistering): left promiscuous mode Jan 29 12:09:27.550934 kernel: docker0: port 1(veth47f6117) entered disabled state Jan 29 12:09:27.588947 systemd[1]: run-docker-netns-6f064ff27f96.mount: Deactivated successfully. Jan 29 12:09:27.594997 systemd[1]: var-lib-docker-overlay2-ba1cd49b2d04327dafd725c3111c3cc5b7cf22fa40abaeb379bd632b996a22af-merged.mount: Deactivated successfully. Jan 29 12:09:27.852095 sshd[1835]: Connection closed by 172.24.4.1 port 54314 Jan 29 12:09:27.851880 sshd-session[1830]: pam_unix(sshd:session): session closed for user core Jan 29 12:09:27.860702 systemd[1]: sshd@10-172.24.4.248:22-172.24.4.1:54314.service: Deactivated successfully. Jan 29 12:09:27.864091 systemd[1]: session-13.scope: Deactivated successfully. Jan 29 12:09:27.865859 systemd-logind[1377]: Session 13 logged out. Waiting for processes to exit. Jan 29 12:09:27.868087 systemd-logind[1377]: Removed session 13. Jan 29 12:09:28.514934 systemd-networkd[1312]: docker0: Lost carrier Jan 29 12:09:30.256543 update_engine[1378]: I20250129 12:09:30.255343 1378 update_attempter.cc:509] Updating boot flags... Jan 29 12:09:30.304803 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1984) Jan 29 12:09:30.383465 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1986) Jan 29 12:09:30.433459 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1986)