May 13 04:11:03.027903 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Mon May 12 22:46:21 -00 2025
May 13 04:11:03.027929 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=a30636f72ddb6c7dc7c9bee07b7cf23b403029ba1ff64eed2705530c62c7b592
May 13 04:11:03.027939 kernel: BIOS-provided physical RAM map:
May 13 04:11:03.027947 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
May 13 04:11:03.027954 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
May 13 04:11:03.027963 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
May 13 04:11:03.027972 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable
May 13 04:11:03.027979 kernel: BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved
May 13 04:11:03.027986 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 13 04:11:03.027993 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
May 13 04:11:03.028001 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable
May 13 04:11:03.028008 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
May 13 04:11:03.028015 kernel: NX (Execute Disable) protection: active
May 13 04:11:03.028024 kernel: APIC: Static calls initialized
May 13 04:11:03.028033 kernel: SMBIOS 3.0.0 present.
May 13 04:11:03.028041 kernel: DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2 04/01/2014
May 13 04:11:03.028049 kernel: Hypervisor detected: KVM
May 13 04:11:03.028056 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
May 13 04:11:03.028064 kernel: kvm-clock: using sched offset of 3468803897 cycles
May 13 04:11:03.028074 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
May 13 04:11:03.028082 kernel: tsc: Detected 1996.249 MHz processor
May 13 04:11:03.028090 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 13 04:11:03.028098 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 13 04:11:03.028106 kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000
May 13 04:11:03.028114 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
May 13 04:11:03.028122 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 13 04:11:03.028130 kernel: last_pfn = 0xbffdd max_arch_pfn = 0x400000000
May 13 04:11:03.028137 kernel: ACPI: Early table checksum verification disabled
May 13 04:11:03.028147 kernel: ACPI: RSDP 0x00000000000F51E0 000014 (v00 BOCHS )
May 13 04:11:03.028155 kernel: ACPI: RSDT 0x00000000BFFE1B65 000030 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 04:11:03.028163 kernel: ACPI: FACP 0x00000000BFFE1A49 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 04:11:03.028171 kernel: ACPI: DSDT 0x00000000BFFE0040 001A09 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 04:11:03.028179 kernel: ACPI: FACS 0x00000000BFFE0000 000040
May 13 04:11:03.028187 kernel: ACPI: APIC 0x00000000BFFE1ABD 000080 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 04:11:03.028194 kernel: ACPI: WAET 0x00000000BFFE1B3D 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 04:11:03.028202 kernel: ACPI: Reserving FACP table memory at [mem 0xbffe1a49-0xbffe1abc]
May 13 04:11:03.029331 kernel: ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a48]
May 13 04:11:03.029343 kernel: ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
May 13 04:11:03.029352 kernel: ACPI: Reserving APIC table memory at [mem 0xbffe1abd-0xbffe1b3c]
May 13 04:11:03.029361 kernel: ACPI: Reserving WAET table memory at [mem 0xbffe1b3d-0xbffe1b64]
May 13 04:11:03.029375 kernel: No NUMA configuration found
May 13 04:11:03.029384 kernel: Faking a node at [mem 0x0000000000000000-0x000000013fffffff]
May 13 04:11:03.029393 kernel: NODE_DATA(0) allocated [mem 0x13fffa000-0x13fffffff]
May 13 04:11:03.029405 kernel: Zone ranges:
May 13 04:11:03.029414 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 13 04:11:03.029423 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 13 04:11:03.029432 kernel:   Normal   [mem 0x0000000100000000-0x000000013fffffff]
May 13 04:11:03.029440 kernel: Movable zone start for each node
May 13 04:11:03.029449 kernel: Early memory node ranges
May 13 04:11:03.029458 kernel:   node   0: [mem 0x0000000000001000-0x000000000009efff]
May 13 04:11:03.029467 kernel:   node   0: [mem 0x0000000000100000-0x00000000bffdcfff]
May 13 04:11:03.029479 kernel:   node   0: [mem 0x0000000100000000-0x000000013fffffff]
May 13 04:11:03.029488 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff]
May 13 04:11:03.029497 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 13 04:11:03.029505 kernel: On node 0, zone DMA: 97 pages in unavailable ranges
May 13 04:11:03.029514 kernel: On node 0, zone Normal: 35 pages in unavailable ranges
May 13 04:11:03.029523 kernel: ACPI: PM-Timer IO Port: 0x608
May 13 04:11:03.029532 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
May 13 04:11:03.029541 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
May 13 04:11:03.029550 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 13 04:11:03.029561 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
May 13 04:11:03.029570 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 13 04:11:03.029579 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
May 13 04:11:03.029588 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
May 13 04:11:03.029596 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 13 04:11:03.029605 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs
May 13 04:11:03.029614 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
May 13 04:11:03.029622 kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices
May 13 04:11:03.029631 kernel: Booting paravirtualized kernel on KVM
May 13 04:11:03.029643 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 13 04:11:03.029652 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
May 13 04:11:03.029661 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576
May 13 04:11:03.029670 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152
May 13 04:11:03.029678 kernel: pcpu-alloc: [0] 0 1 
May 13 04:11:03.029687 kernel: kvm-guest: PV spinlocks disabled, no host support
May 13 04:11:03.029697 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=a30636f72ddb6c7dc7c9bee07b7cf23b403029ba1ff64eed2705530c62c7b592
May 13 04:11:03.029707 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 13 04:11:03.029718 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 13 04:11:03.029727 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 13 04:11:03.029735 kernel: Fallback order for Node 0: 0 
May 13 04:11:03.029744 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 1031901
May 13 04:11:03.029753 kernel: Policy zone: Normal
May 13 04:11:03.029762 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 13 04:11:03.029770 kernel: software IO TLB: area num 2.
May 13 04:11:03.029780 kernel: Memory: 3966216K/4193772K available (12288K kernel code, 2295K rwdata, 22740K rodata, 42864K init, 2328K bss, 227296K reserved, 0K cma-reserved)
May 13 04:11:03.029789 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
May 13 04:11:03.029800 kernel: ftrace: allocating 37944 entries in 149 pages
May 13 04:11:03.029809 kernel: ftrace: allocated 149 pages with 4 groups
May 13 04:11:03.029817 kernel: Dynamic Preempt: voluntary
May 13 04:11:03.029826 kernel: rcu: Preemptible hierarchical RCU implementation.
May 13 04:11:03.029836 kernel: rcu:         RCU event tracing is enabled.
May 13 04:11:03.029845 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
May 13 04:11:03.029853 kernel:         Trampoline variant of Tasks RCU enabled.
May 13 04:11:03.029862 kernel:         Rude variant of Tasks RCU enabled.
May 13 04:11:03.029871 kernel:         Tracing variant of Tasks RCU enabled.
May 13 04:11:03.029881 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 13 04:11:03.029890 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
May 13 04:11:03.029899 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16
May 13 04:11:03.029908 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 13 04:11:03.029917 kernel: Console: colour VGA+ 80x25
May 13 04:11:03.029926 kernel: printk: console [tty0] enabled
May 13 04:11:03.029934 kernel: printk: console [ttyS0] enabled
May 13 04:11:03.029943 kernel: ACPI: Core revision 20230628
May 13 04:11:03.029952 kernel: APIC: Switch to symmetric I/O mode setup
May 13 04:11:03.029961 kernel: x2apic enabled
May 13 04:11:03.029972 kernel: APIC: Switched APIC routing to: physical x2apic
May 13 04:11:03.029980 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
May 13 04:11:03.029989 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized
May 13 04:11:03.029998 kernel: Calibrating delay loop (skipped) preset value.. 3992.49 BogoMIPS (lpj=1996249)
May 13 04:11:03.030007 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
May 13 04:11:03.030016 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
May 13 04:11:03.030025 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 13 04:11:03.030034 kernel: Spectre V2 : Mitigation: Retpolines
May 13 04:11:03.030043 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
May 13 04:11:03.030053 kernel: Speculative Store Bypass: Vulnerable
May 13 04:11:03.030062 kernel: x86/fpu: x87 FPU will use FXSAVE
May 13 04:11:03.030071 kernel: Freeing SMP alternatives memory: 32K
May 13 04:11:03.030080 kernel: pid_max: default: 32768 minimum: 301
May 13 04:11:03.030096 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
May 13 04:11:03.030107 kernel: landlock: Up and running.
May 13 04:11:03.030116 kernel: SELinux:  Initializing.
May 13 04:11:03.030126 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 13 04:11:03.030135 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 13 04:11:03.030144 kernel: smpboot: CPU0: AMD Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3)
May 13 04:11:03.030154 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 04:11:03.030165 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 04:11:03.030175 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 04:11:03.030184 kernel: Performance Events: AMD PMU driver.
May 13 04:11:03.030193 kernel: ... version:                0
May 13 04:11:03.030202 kernel: ... bit width:              48
May 13 04:11:03.030248 kernel: ... generic registers:      4
May 13 04:11:03.030258 kernel: ... value mask:             0000ffffffffffff
May 13 04:11:03.030376 kernel: ... max period:             00007fffffffffff
May 13 04:11:03.030386 kernel: ... fixed-purpose events:   0
May 13 04:11:03.030395 kernel: ... event mask:             000000000000000f
May 13 04:11:03.030405 kernel: signal: max sigframe size: 1440
May 13 04:11:03.030414 kernel: rcu: Hierarchical SRCU implementation.
May 13 04:11:03.030423 kernel: rcu:         Max phase no-delay instances is 400.
May 13 04:11:03.030433 kernel: smp: Bringing up secondary CPUs ...
May 13 04:11:03.030445 kernel: smpboot: x86: Booting SMP configuration:
May 13 04:11:03.030454 kernel: .... node  #0, CPUs:      #1
May 13 04:11:03.030464 kernel: smp: Brought up 1 node, 2 CPUs
May 13 04:11:03.030473 kernel: smpboot: Max logical packages: 2
May 13 04:11:03.030482 kernel: smpboot: Total of 2 processors activated (7984.99 BogoMIPS)
May 13 04:11:03.030491 kernel: devtmpfs: initialized
May 13 04:11:03.030501 kernel: x86/mm: Memory block size: 128MB
May 13 04:11:03.030510 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 13 04:11:03.030519 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
May 13 04:11:03.030531 kernel: pinctrl core: initialized pinctrl subsystem
May 13 04:11:03.030540 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 13 04:11:03.030549 kernel: audit: initializing netlink subsys (disabled)
May 13 04:11:03.030559 kernel: audit: type=2000 audit(1747109461.905:1): state=initialized audit_enabled=0 res=1
May 13 04:11:03.030568 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 13 04:11:03.030577 kernel: thermal_sys: Registered thermal governor 'user_space'
May 13 04:11:03.030586 kernel: cpuidle: using governor menu
May 13 04:11:03.030596 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 13 04:11:03.030605 kernel: dca service started, version 1.12.1
May 13 04:11:03.030618 kernel: PCI: Using configuration type 1 for base access
May 13 04:11:03.030627 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 13 04:11:03.030636 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 13 04:11:03.030645 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 13 04:11:03.030653 kernel: ACPI: Added _OSI(Module Device)
May 13 04:11:03.030662 kernel: ACPI: Added _OSI(Processor Device)
May 13 04:11:03.030671 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 13 04:11:03.030679 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 13 04:11:03.030688 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 13 04:11:03.030696 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC
May 13 04:11:03.030707 kernel: ACPI: Interpreter enabled
May 13 04:11:03.030716 kernel: ACPI: PM: (supports S0 S3 S5)
May 13 04:11:03.030724 kernel: ACPI: Using IOAPIC for interrupt routing
May 13 04:11:03.030733 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 13 04:11:03.030742 kernel: PCI: Using E820 reservations for host bridge windows
May 13 04:11:03.030751 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F
May 13 04:11:03.030759 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 13 04:11:03.031146 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
May 13 04:11:03.031275 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
May 13 04:11:03.031368 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge
May 13 04:11:03.031381 kernel: acpiphp: Slot [3] registered
May 13 04:11:03.031391 kernel: acpiphp: Slot [4] registered
May 13 04:11:03.031399 kernel: acpiphp: Slot [5] registered
May 13 04:11:03.031408 kernel: acpiphp: Slot [6] registered
May 13 04:11:03.031416 kernel: acpiphp: Slot [7] registered
May 13 04:11:03.031425 kernel: acpiphp: Slot [8] registered
May 13 04:11:03.031439 kernel: acpiphp: Slot [9] registered
May 13 04:11:03.031447 kernel: acpiphp: Slot [10] registered
May 13 04:11:03.031456 kernel: acpiphp: Slot [11] registered
May 13 04:11:03.031464 kernel: acpiphp: Slot [12] registered
May 13 04:11:03.031472 kernel: acpiphp: Slot [13] registered
May 13 04:11:03.031481 kernel: acpiphp: Slot [14] registered
May 13 04:11:03.031489 kernel: acpiphp: Slot [15] registered
May 13 04:11:03.031498 kernel: acpiphp: Slot [16] registered
May 13 04:11:03.031506 kernel: acpiphp: Slot [17] registered
May 13 04:11:03.031517 kernel: acpiphp: Slot [18] registered
May 13 04:11:03.031525 kernel: acpiphp: Slot [19] registered
May 13 04:11:03.031534 kernel: acpiphp: Slot [20] registered
May 13 04:11:03.031542 kernel: acpiphp: Slot [21] registered
May 13 04:11:03.031551 kernel: acpiphp: Slot [22] registered
May 13 04:11:03.031559 kernel: acpiphp: Slot [23] registered
May 13 04:11:03.031567 kernel: acpiphp: Slot [24] registered
May 13 04:11:03.031576 kernel: acpiphp: Slot [25] registered
May 13 04:11:03.031584 kernel: acpiphp: Slot [26] registered
May 13 04:11:03.031593 kernel: acpiphp: Slot [27] registered
May 13 04:11:03.031604 kernel: acpiphp: Slot [28] registered
May 13 04:11:03.031612 kernel: acpiphp: Slot [29] registered
May 13 04:11:03.031621 kernel: acpiphp: Slot [30] registered
May 13 04:11:03.031629 kernel: acpiphp: Slot [31] registered
May 13 04:11:03.031638 kernel: PCI host bridge to bus 0000:00
May 13 04:11:03.031732 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
May 13 04:11:03.031816 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
May 13 04:11:03.031896 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 13 04:11:03.031980 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
May 13 04:11:03.032061 kernel: pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window]
May 13 04:11:03.032142 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
May 13 04:11:03.034297 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
May 13 04:11:03.034413 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
May 13 04:11:03.034520 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
May 13 04:11:03.034628 kernel: pci 0000:00:01.1: reg 0x20: [io  0xc120-0xc12f]
May 13 04:11:03.034718 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
May 13 04:11:03.034807 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
May 13 04:11:03.034896 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
May 13 04:11:03.034985 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
May 13 04:11:03.035081 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
May 13 04:11:03.035173 kernel: pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
May 13 04:11:03.036015 kernel: pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
May 13 04:11:03.036119 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000
May 13 04:11:03.036233 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfe000000-0xfe7fffff pref]
May 13 04:11:03.036327 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc000000000-0xc000003fff 64bit pref]
May 13 04:11:03.036417 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfeb90000-0xfeb90fff]
May 13 04:11:03.036505 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfeb8ffff pref]
May 13 04:11:03.036600 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
May 13 04:11:03.036700 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
May 13 04:11:03.036791 kernel: pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc0bf]
May 13 04:11:03.036882 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfeb91000-0xfeb91fff]
May 13 04:11:03.036986 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xc000004000-0xc000007fff 64bit pref]
May 13 04:11:03.037086 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref]
May 13 04:11:03.037189 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
May 13 04:11:03.038336 kernel: pci 0000:00:04.0: reg 0x10: [io  0xc000-0xc07f]
May 13 04:11:03.038436 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfeb92000-0xfeb92fff]
May 13 04:11:03.038533 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xc000008000-0xc00000bfff 64bit pref]
May 13 04:11:03.038645 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00
May 13 04:11:03.038735 kernel: pci 0000:00:05.0: reg 0x10: [io  0xc0c0-0xc0ff]
May 13 04:11:03.038824 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xc00000c000-0xc00000ffff 64bit pref]
May 13 04:11:03.038926 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00
May 13 04:11:03.039021 kernel: pci 0000:00:06.0: reg 0x10: [io  0xc100-0xc11f]
May 13 04:11:03.039110 kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfeb93000-0xfeb93fff]
May 13 04:11:03.039199 kernel: pci 0000:00:06.0: reg 0x20: [mem 0xc000010000-0xc000013fff 64bit pref]
May 13 04:11:03.040342 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10
May 13 04:11:03.040354 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
May 13 04:11:03.040363 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11
May 13 04:11:03.040372 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
May 13 04:11:03.040381 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9
May 13 04:11:03.040394 kernel: iommu: Default domain type: Translated
May 13 04:11:03.040402 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 13 04:11:03.040411 kernel: PCI: Using ACPI for IRQ routing
May 13 04:11:03.040420 kernel: PCI: pci_cache_line_size set to 64 bytes
May 13 04:11:03.040428 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
May 13 04:11:03.040437 kernel: e820: reserve RAM buffer [mem 0xbffdd000-0xbfffffff]
May 13 04:11:03.040536 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
May 13 04:11:03.040628 kernel: pci 0000:00:02.0: vgaarb: bridge control possible
May 13 04:11:03.040717 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
May 13 04:11:03.040733 kernel: vgaarb: loaded
May 13 04:11:03.040743 kernel: clocksource: Switched to clocksource kvm-clock
May 13 04:11:03.040751 kernel: VFS: Disk quotas dquot_6.6.0
May 13 04:11:03.040760 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 13 04:11:03.040769 kernel: pnp: PnP ACPI init
May 13 04:11:03.040857 kernel: pnp 00:03: [dma 2]
May 13 04:11:03.040872 kernel: pnp: PnP ACPI: found 5 devices
May 13 04:11:03.040881 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 13 04:11:03.040889 kernel: NET: Registered PF_INET protocol family
May 13 04:11:03.040902 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
May 13 04:11:03.040910 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
May 13 04:11:03.040919 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 13 04:11:03.040928 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 13 04:11:03.040937 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
May 13 04:11:03.041402 kernel: TCP: Hash tables configured (established 32768 bind 32768)
May 13 04:11:03.041412 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 13 04:11:03.043245 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 13 04:11:03.043259 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 13 04:11:03.043267 kernel: NET: Registered PF_XDP protocol family
May 13 04:11:03.043364 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
May 13 04:11:03.043443 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
May 13 04:11:03.043521 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 13 04:11:03.043599 kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
May 13 04:11:03.043677 kernel: pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window]
May 13 04:11:03.043855 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release
May 13 04:11:03.043954 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers
May 13 04:11:03.043968 kernel: PCI: CLS 0 bytes, default 64
May 13 04:11:03.043977 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 13 04:11:03.043986 kernel: software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB)
May 13 04:11:03.043995 kernel: Initialise system trusted keyrings
May 13 04:11:03.044004 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
May 13 04:11:03.044012 kernel: Key type asymmetric registered
May 13 04:11:03.044021 kernel: Asymmetric key parser 'x509' registered
May 13 04:11:03.044030 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
May 13 04:11:03.044041 kernel: io scheduler mq-deadline registered
May 13 04:11:03.044050 kernel: io scheduler kyber registered
May 13 04:11:03.044059 kernel: io scheduler bfq registered
May 13 04:11:03.044068 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 13 04:11:03.044077 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10
May 13 04:11:03.044086 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11
May 13 04:11:03.044095 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11
May 13 04:11:03.044104 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10
May 13 04:11:03.044113 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 13 04:11:03.044124 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 13 04:11:03.044134 kernel: random: crng init done
May 13 04:11:03.044142 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
May 13 04:11:03.044151 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
May 13 04:11:03.044160 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
May 13 04:11:03.044272 kernel: rtc_cmos 00:04: RTC can wake from S4
May 13 04:11:03.044287 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
May 13 04:11:03.044367 kernel: rtc_cmos 00:04: registered as rtc0
May 13 04:11:03.044453 kernel: rtc_cmos 00:04: setting system clock to 2025-05-13T04:11:02 UTC (1747109462)
May 13 04:11:03.044535 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram
May 13 04:11:03.044548 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
May 13 04:11:03.044557 kernel: NET: Registered PF_INET6 protocol family
May 13 04:11:03.044566 kernel: Segment Routing with IPv6
May 13 04:11:03.044575 kernel: In-situ OAM (IOAM) with IPv6
May 13 04:11:03.044583 kernel: NET: Registered PF_PACKET protocol family
May 13 04:11:03.044592 kernel: Key type dns_resolver registered
May 13 04:11:03.044601 kernel: IPI shorthand broadcast: enabled
May 13 04:11:03.044613 kernel: sched_clock: Marking stable (979007007, 175189641)->(1184190239, -29993591)
May 13 04:11:03.044622 kernel: registered taskstats version 1
May 13 04:11:03.044631 kernel: Loading compiled-in X.509 certificates
May 13 04:11:03.044640 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: b404fdaaed18d29adfca671c3bbb23eee96fb08f'
May 13 04:11:03.044648 kernel: Key type .fscrypt registered
May 13 04:11:03.044657 kernel: Key type fscrypt-provisioning registered
May 13 04:11:03.044666 kernel: ima: No TPM chip found, activating TPM-bypass!
May 13 04:11:03.044675 kernel: ima: Allocated hash algorithm: sha1
May 13 04:11:03.044683 kernel: ima: No architecture policies found
May 13 04:11:03.044694 kernel: clk: Disabling unused clocks
May 13 04:11:03.044703 kernel: Freeing unused kernel image (initmem) memory: 42864K
May 13 04:11:03.044712 kernel: Write protecting the kernel read-only data: 36864k
May 13 04:11:03.044721 kernel: Freeing unused kernel image (rodata/data gap) memory: 1836K
May 13 04:11:03.044729 kernel: Run /init as init process
May 13 04:11:03.044738 kernel:   with arguments:
May 13 04:11:03.044746 kernel:     /init
May 13 04:11:03.044755 kernel:   with environment:
May 13 04:11:03.044763 kernel:     HOME=/
May 13 04:11:03.044774 kernel:     TERM=linux
May 13 04:11:03.044782 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 13 04:11:03.044793 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
May 13 04:11:03.044805 systemd[1]: Detected virtualization kvm.
May 13 04:11:03.044815 systemd[1]: Detected architecture x86-64.
May 13 04:11:03.044824 systemd[1]: Running in initrd.
May 13 04:11:03.044834 systemd[1]: No hostname configured, using default hostname.
May 13 04:11:03.044845 systemd[1]: Hostname set to <localhost>.
May 13 04:11:03.044855 systemd[1]: Initializing machine ID from VM UUID.
May 13 04:11:03.044864 systemd[1]: Queued start job for default target initrd.target.
May 13 04:11:03.044874 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 04:11:03.044884 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 04:11:03.044894 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 13 04:11:03.044904 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 13 04:11:03.044922 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 13 04:11:03.044934 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 13 04:11:03.044945 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 13 04:11:03.044967 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 13 04:11:03.044978 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 04:11:03.044991 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 13 04:11:03.045000 systemd[1]: Reached target paths.target - Path Units.
May 13 04:11:03.045010 systemd[1]: Reached target slices.target - Slice Units.
May 13 04:11:03.045020 systemd[1]: Reached target swap.target - Swaps.
May 13 04:11:03.045030 systemd[1]: Reached target timers.target - Timer Units.
May 13 04:11:03.045040 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 13 04:11:03.045050 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 13 04:11:03.045059 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 13 04:11:03.045069 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
May 13 04:11:03.045081 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 13 04:11:03.045091 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 13 04:11:03.045101 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 04:11:03.045110 systemd[1]: Reached target sockets.target - Socket Units.
May 13 04:11:03.045120 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 13 04:11:03.045130 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 13 04:11:03.045140 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 13 04:11:03.045149 systemd[1]: Starting systemd-fsck-usr.service...
May 13 04:11:03.045159 systemd[1]: Starting systemd-journald.service - Journal Service...
May 13 04:11:03.045171 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 13 04:11:03.045181 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 04:11:03.046242 systemd-journald[185]: Collecting audit messages is disabled.
May 13 04:11:03.046271 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 13 04:11:03.046286 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 04:11:03.046296 systemd[1]: Finished systemd-fsck-usr.service.
May 13 04:11:03.046307 systemd-journald[185]: Journal started
May 13 04:11:03.046332 systemd-journald[185]: Runtime Journal (/run/log/journal/1eb6c995cc8a4b4686108dfa5150f200) is 8.0M, max 78.3M, 70.3M free.
May 13 04:11:03.045690 systemd-modules-load[186]: Inserted module 'overlay'
May 13 04:11:03.089678 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
May 13 04:11:03.089699 kernel: Bridge firewalling registered
May 13 04:11:03.089710 systemd[1]: Started systemd-journald.service - Journal Service.
May 13 04:11:03.074236 systemd-modules-load[186]: Inserted module 'br_netfilter'
May 13 04:11:03.090413 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 13 04:11:03.091451 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:03.097352 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 04:11:03.099095 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 13 04:11:03.102341 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 13 04:11:03.107391 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 13 04:11:03.122193 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 04:11:03.123698 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 13 04:11:03.125313 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 04:11:03.127117 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 04:11:03.135389 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 13 04:11:03.140372 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 13 04:11:03.142920 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 13 04:11:03.150085 dracut-cmdline[216]: dracut-dracut-053
May 13 04:11:03.152152 dracut-cmdline[216]: 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=a30636f72ddb6c7dc7c9bee07b7cf23b403029ba1ff64eed2705530c62c7b592
May 13 04:11:03.162386 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 04:11:03.188361 systemd-resolved[218]: Positive Trust Anchors:
May 13 04:11:03.188374 systemd-resolved[218]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 13 04:11:03.188417 systemd-resolved[218]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 13 04:11:03.195391 systemd-resolved[218]: Defaulting to hostname 'linux'.
May 13 04:11:03.196472 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 13 04:11:03.197391 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 13 04:11:03.237263 kernel: SCSI subsystem initialized
May 13 04:11:03.249296 kernel: Loading iSCSI transport class v2.0-870.
May 13 04:11:03.262285 kernel: iscsi: registered transport (tcp)
May 13 04:11:03.286598 kernel: iscsi: registered transport (qla4xxx)
May 13 04:11:03.286666 kernel: QLogic iSCSI HBA Driver
May 13 04:11:03.345826 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 13 04:11:03.351439 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 13 04:11:03.406400 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 13 04:11:03.406518 kernel: device-mapper: uevent: version 1.0.3
May 13 04:11:03.408951 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
May 13 04:11:03.456320 kernel: raid6: sse2x4   gen() 13151 MB/s
May 13 04:11:03.474273 kernel: raid6: sse2x2   gen() 15168 MB/s
May 13 04:11:03.492606 kernel: raid6: sse2x1   gen() 10154 MB/s
May 13 04:11:03.492678 kernel: raid6: using algorithm sse2x2 gen() 15168 MB/s
May 13 04:11:03.511597 kernel: raid6: .... xor() 9377 MB/s, rmw enabled
May 13 04:11:03.511669 kernel: raid6: using ssse3x2 recovery algorithm
May 13 04:11:03.533268 kernel: xor: measuring software checksum speed
May 13 04:11:03.533340 kernel:    prefetch64-sse  : 15890 MB/sec
May 13 04:11:03.535671 kernel:    generic_sse     : 16869 MB/sec
May 13 04:11:03.535715 kernel: xor: using function: generic_sse (16869 MB/sec)
May 13 04:11:03.720290 kernel: Btrfs loaded, zoned=no, fsverity=no
May 13 04:11:03.738305 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 13 04:11:03.744536 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 04:11:03.757377 systemd-udevd[404]: Using default interface naming scheme 'v255'.
May 13 04:11:03.761762 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 04:11:03.772918 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 13 04:11:03.789892 dracut-pre-trigger[413]: rd.md=0: removing MD RAID activation
May 13 04:11:03.829417 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 13 04:11:03.845515 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 13 04:11:03.889845 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 04:11:03.898389 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 13 04:11:03.941844 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 13 04:11:03.943153 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 13 04:11:03.946008 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 04:11:03.947272 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 13 04:11:03.954360 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 13 04:11:03.976854 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 13 04:11:03.991249 kernel: virtio_blk virtio2: 2/0/0 default/read/poll queues
May 13 04:11:03.994626 kernel: virtio_blk virtio2: [vda] 20971520 512-byte logical blocks (10.7 GB/10.0 GiB)
May 13 04:11:04.013749 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
May 13 04:11:04.013789 kernel: GPT:17805311 != 20971519
May 13 04:11:04.013802 kernel: GPT:Alternate GPT header not at the end of the disk.
May 13 04:11:04.013814 kernel: GPT:17805311 != 20971519
May 13 04:11:04.013833 kernel: GPT: Use GNU Parted to correct GPT errors.
May 13 04:11:04.013845 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 04:11:04.020633 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 13 04:11:04.021472 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 04:11:04.024023 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 04:11:04.026347 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 04:11:04.027402 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:04.029025 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 13 04:11:04.032247 kernel: libata version 3.00 loaded.
May 13 04:11:04.033470 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 04:11:04.036550 kernel: ata_piix 0000:00:01.1: version 2.13
May 13 04:11:04.036920 kernel: scsi host0: ata_piix
May 13 04:11:04.038939 kernel: scsi host1: ata_piix
May 13 04:11:04.041469 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14
May 13 04:11:04.041485 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15
May 13 04:11:04.061266 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (468)
May 13 04:11:04.068234 kernel: BTRFS: device fsid b9c18834-b687-45d3-9868-9ac29dc7ddd7 devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (467)
May 13 04:11:04.096820 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
May 13 04:11:04.127698 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:04.142914 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
May 13 04:11:04.155307 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
May 13 04:11:04.156783 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
May 13 04:11:04.171869 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 13 04:11:04.185495 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 13 04:11:04.190504 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 04:11:04.197614 disk-uuid[504]: Primary Header is updated.
May 13 04:11:04.197614 disk-uuid[504]: Secondary Entries is updated.
May 13 04:11:04.197614 disk-uuid[504]: Secondary Header is updated.
May 13 04:11:04.213293 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 04:11:04.230277 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 04:11:04.247273 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 04:11:04.249967 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 04:11:05.244108 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 04:11:05.244307 disk-uuid[505]: The operation has completed successfully.
May 13 04:11:05.316987 systemd[1]: disk-uuid.service: Deactivated successfully.
May 13 04:11:05.317275 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 13 04:11:05.357353 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 13 04:11:05.377950 sh[526]: Success
May 13 04:11:05.400245 kernel: device-mapper: verity: sha256 using implementation "sha256-ssse3"
May 13 04:11:05.482940 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 13 04:11:05.490467 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 13 04:11:05.493445 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 13 04:11:05.528296 kernel: BTRFS info (device dm-0): first mount of filesystem b9c18834-b687-45d3-9868-9ac29dc7ddd7
May 13 04:11:05.528404 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 13 04:11:05.532305 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
May 13 04:11:05.536246 kernel: BTRFS info (device dm-0): disabling log replay at mount time
May 13 04:11:05.536285 kernel: BTRFS info (device dm-0): using free space tree
May 13 04:11:05.551677 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 13 04:11:05.553813 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 13 04:11:05.560578 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 13 04:11:05.564919 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 13 04:11:05.585307 kernel: BTRFS info (device vda6): first mount of filesystem 97fe19c2-c075-4d7e-9417-f9c367b49e5c
May 13 04:11:05.585360 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 04:11:05.589507 kernel: BTRFS info (device vda6): using free space tree
May 13 04:11:05.601261 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 04:11:05.620907 systemd[1]: mnt-oem.mount: Deactivated successfully.
May 13 04:11:05.624772 kernel: BTRFS info (device vda6): last unmount of filesystem 97fe19c2-c075-4d7e-9417-f9c367b49e5c
May 13 04:11:05.644706 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 13 04:11:05.653487 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 13 04:11:05.681449 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 13 04:11:05.689429 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 13 04:11:05.726147 systemd-networkd[708]: lo: Link UP
May 13 04:11:05.726596 systemd-networkd[708]: lo: Gained carrier
May 13 04:11:05.728652 systemd-networkd[708]: Enumeration completed
May 13 04:11:05.728749 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 13 04:11:05.729462 systemd[1]: Reached target network.target - Network.
May 13 04:11:05.730880 systemd-networkd[708]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 04:11:05.730883 systemd-networkd[708]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 13 04:11:05.731855 systemd-networkd[708]: eth0: Link UP
May 13 04:11:05.731858 systemd-networkd[708]: eth0: Gained carrier
May 13 04:11:05.731866 systemd-networkd[708]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 04:11:05.743254 systemd-networkd[708]: eth0: DHCPv4 address 172.24.4.202/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 13 04:11:05.814654 ignition[666]: Ignition 2.19.0
May 13 04:11:05.814674 ignition[666]: Stage: fetch-offline
May 13 04:11:05.817570 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 13 04:11:05.814724 ignition[666]: no configs at "/usr/lib/ignition/base.d"
May 13 04:11:05.814736 ignition[666]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:05.814858 ignition[666]: parsed url from cmdline: ""
May 13 04:11:05.814863 ignition[666]: no config URL provided
May 13 04:11:05.814869 ignition[666]: reading system config file "/usr/lib/ignition/user.ign"
May 13 04:11:05.814880 ignition[666]: no config at "/usr/lib/ignition/user.ign"
May 13 04:11:05.814886 ignition[666]: failed to fetch config: resource requires networking
May 13 04:11:05.816090 ignition[666]: Ignition finished successfully
May 13 04:11:05.824385 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
May 13 04:11:05.837707 ignition[718]: Ignition 2.19.0
May 13 04:11:05.837719 ignition[718]: Stage: fetch
May 13 04:11:05.837905 ignition[718]: no configs at "/usr/lib/ignition/base.d"
May 13 04:11:05.837917 ignition[718]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:05.838006 ignition[718]: parsed url from cmdline: ""
May 13 04:11:05.838010 ignition[718]: no config URL provided
May 13 04:11:05.838022 ignition[718]: reading system config file "/usr/lib/ignition/user.ign"
May 13 04:11:05.838030 ignition[718]: no config at "/usr/lib/ignition/user.ign"
May 13 04:11:05.838152 ignition[718]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1
May 13 04:11:05.838263 ignition[718]: config drive ("/dev/disk/by-label/config-2") not found. Waiting...
May 13 04:11:05.838297 ignition[718]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting...
May 13 04:11:06.307954 ignition[718]: GET result: OK
May 13 04:11:06.308041 ignition[718]: parsing config with SHA512: be7f24b922e44af560025407125ec0548dba4e7ca722c4ac1d4ddef93746c8e2acb300d22a55e7dc64c0c95636a42382a80b36aae9b607ed08739af01d565550
May 13 04:11:06.318932 unknown[718]: fetched base config from "system"
May 13 04:11:06.319355 ignition[718]: fetch: fetch complete
May 13 04:11:06.318960 unknown[718]: fetched base config from "system"
May 13 04:11:06.319367 ignition[718]: fetch: fetch passed
May 13 04:11:06.318974 unknown[718]: fetched user config from "openstack"
May 13 04:11:06.319444 ignition[718]: Ignition finished successfully
May 13 04:11:06.323375 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
May 13 04:11:06.341370 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 13 04:11:06.370088 ignition[724]: Ignition 2.19.0
May 13 04:11:06.370114 ignition[724]: Stage: kargs
May 13 04:11:06.370578 ignition[724]: no configs at "/usr/lib/ignition/base.d"
May 13 04:11:06.370604 ignition[724]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:06.374541 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 13 04:11:06.372115 ignition[724]: kargs: kargs passed
May 13 04:11:06.372252 ignition[724]: Ignition finished successfully
May 13 04:11:06.383645 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 13 04:11:06.423692 ignition[731]: Ignition 2.19.0
May 13 04:11:06.425331 ignition[731]: Stage: disks
May 13 04:11:06.425756 ignition[731]: no configs at "/usr/lib/ignition/base.d"
May 13 04:11:06.425782 ignition[731]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:06.431740 ignition[731]: disks: disks passed
May 13 04:11:06.433076 ignition[731]: Ignition finished successfully
May 13 04:11:06.436489 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 13 04:11:06.438662 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 13 04:11:06.440563 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 13 04:11:06.443469 systemd[1]: Reached target local-fs.target - Local File Systems.
May 13 04:11:06.446398 systemd[1]: Reached target sysinit.target - System Initialization.
May 13 04:11:06.449030 systemd[1]: Reached target basic.target - Basic System.
May 13 04:11:06.464586 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 13 04:11:06.494176 systemd-fsck[739]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks
May 13 04:11:06.512610 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 13 04:11:06.520442 systemd[1]: Mounting sysroot.mount - /sysroot...
May 13 04:11:06.692313 kernel: EXT4-fs (vda9): mounted filesystem 422ad498-4f61-405b-9d71-25f19459d196 r/w with ordered data mode. Quota mode: none.
May 13 04:11:06.694324 systemd[1]: Mounted sysroot.mount - /sysroot.
May 13 04:11:06.697817 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 13 04:11:06.705405 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 13 04:11:06.709188 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 13 04:11:06.710726 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
May 13 04:11:06.714276 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent...
May 13 04:11:06.715591 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 13 04:11:06.715621 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 13 04:11:06.724237 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (747)
May 13 04:11:06.732273 kernel: BTRFS info (device vda6): first mount of filesystem 97fe19c2-c075-4d7e-9417-f9c367b49e5c
May 13 04:11:06.732368 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 04:11:06.732399 kernel: BTRFS info (device vda6): using free space tree
May 13 04:11:06.735429 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 13 04:11:06.756488 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 13 04:11:06.802407 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 04:11:06.814405 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 13 04:11:06.960342 initrd-setup-root[777]: cut: /sysroot/etc/passwd: No such file or directory
May 13 04:11:06.966522 initrd-setup-root[784]: cut: /sysroot/etc/group: No such file or directory
May 13 04:11:06.971082 initrd-setup-root[792]: cut: /sysroot/etc/shadow: No such file or directory
May 13 04:11:06.977421 initrd-setup-root[799]: cut: /sysroot/etc/gshadow: No such file or directory
May 13 04:11:07.075332 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 13 04:11:07.080332 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 13 04:11:07.083359 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 13 04:11:07.090683 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 13 04:11:07.094782 kernel: BTRFS info (device vda6): last unmount of filesystem 97fe19c2-c075-4d7e-9417-f9c367b49e5c
May 13 04:11:07.115653 ignition[866]: INFO     : Ignition 2.19.0
May 13 04:11:07.115653 ignition[866]: INFO     : Stage: mount
May 13 04:11:07.120558 ignition[866]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 04:11:07.120558 ignition[866]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:07.120558 ignition[866]: INFO     : mount: mount passed
May 13 04:11:07.120558 ignition[866]: INFO     : Ignition finished successfully
May 13 04:11:07.121657 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 13 04:11:07.131625 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 13 04:11:07.656632 systemd-networkd[708]: eth0: Gained IPv6LL
May 13 04:11:14.054919 coreos-metadata[749]: May 13 04:11:14.054 WARN failed to locate config-drive, using the metadata service API instead
May 13 04:11:14.095649 coreos-metadata[749]: May 13 04:11:14.095 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 13 04:11:14.112500 coreos-metadata[749]: May 13 04:11:14.112 INFO Fetch successful
May 13 04:11:14.114137 coreos-metadata[749]: May 13 04:11:14.112 INFO wrote hostname ci-4081-3-3-n-300cc17afe.novalocal to /sysroot/etc/hostname
May 13 04:11:14.118421 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully.
May 13 04:11:14.118685 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent.
May 13 04:11:14.131441 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 13 04:11:14.162543 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 13 04:11:14.180270 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (883)
May 13 04:11:14.187939 kernel: BTRFS info (device vda6): first mount of filesystem 97fe19c2-c075-4d7e-9417-f9c367b49e5c
May 13 04:11:14.188002 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 04:11:14.192307 kernel: BTRFS info (device vda6): using free space tree
May 13 04:11:14.203329 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 04:11:14.208735 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 13 04:11:14.261242 ignition[901]: INFO     : Ignition 2.19.0
May 13 04:11:14.261242 ignition[901]: INFO     : Stage: files
May 13 04:11:14.264190 ignition[901]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 04:11:14.264190 ignition[901]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:14.264190 ignition[901]: DEBUG    : files: compiled without relabeling support, skipping
May 13 04:11:14.269932 ignition[901]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 13 04:11:14.269932 ignition[901]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 13 04:11:14.274591 ignition[901]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 13 04:11:14.274591 ignition[901]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 13 04:11:14.278547 ignition[901]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 13 04:11:14.278547 ignition[901]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 13 04:11:14.275444 unknown[901]: wrote ssh authorized keys file for user: core
May 13 04:11:14.285467 ignition[901]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 13 04:11:14.285467 ignition[901]: INFO     : files: createResultFile: createFiles: op(4): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 13 04:11:14.285467 ignition[901]: INFO     : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 13 04:11:14.285467 ignition[901]: INFO     : files: files passed
May 13 04:11:14.285467 ignition[901]: INFO     : Ignition finished successfully
May 13 04:11:14.282025 systemd[1]: Finished ignition-files.service - Ignition (files).
May 13 04:11:14.292553 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 13 04:11:14.302795 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 13 04:11:14.306412 systemd[1]: ignition-quench.service: Deactivated successfully.
May 13 04:11:14.306622 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 13 04:11:14.317557 initrd-setup-root-after-ignition[929]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 13 04:11:14.317557 initrd-setup-root-after-ignition[929]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 13 04:11:14.323820 initrd-setup-root-after-ignition[933]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 13 04:11:14.324000 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 13 04:11:14.327060 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 13 04:11:14.333498 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 13 04:11:14.367873 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 13 04:11:14.367981 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 13 04:11:14.369499 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 13 04:11:14.370501 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 13 04:11:14.371692 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 13 04:11:14.373141 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 13 04:11:14.389110 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 13 04:11:14.393351 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 13 04:11:14.404390 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 13 04:11:14.405037 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 04:11:14.405691 systemd[1]: Stopped target timers.target - Timer Units.
May 13 04:11:14.406268 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 13 04:11:14.406386 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 13 04:11:14.408050 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 13 04:11:14.408817 systemd[1]: Stopped target basic.target - Basic System.
May 13 04:11:14.409793 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 13 04:11:14.410867 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 13 04:11:14.412110 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 13 04:11:14.413168 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 13 04:11:14.414155 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 13 04:11:14.415400 systemd[1]: Stopped target sysinit.target - System Initialization.
May 13 04:11:14.416586 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 13 04:11:14.417872 systemd[1]: Stopped target swap.target - Swaps.
May 13 04:11:14.418958 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 13 04:11:14.419072 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 13 04:11:14.420675 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 13 04:11:14.421489 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 04:11:14.426194 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 13 04:11:14.426329 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 04:11:14.427279 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 13 04:11:14.427392 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 13 04:11:14.428832 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 13 04:11:14.429010 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 13 04:11:14.429762 systemd[1]: ignition-files.service: Deactivated successfully.
May 13 04:11:14.429913 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 13 04:11:14.437357 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 13 04:11:14.439172 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 13 04:11:14.440380 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 13 04:11:14.441298 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 04:11:14.442869 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 13 04:11:14.443693 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 13 04:11:14.453101 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 13 04:11:14.453852 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 13 04:11:14.458359 ignition[953]: INFO     : Ignition 2.19.0
May 13 04:11:14.458359 ignition[953]: INFO     : Stage: umount
May 13 04:11:14.458359 ignition[953]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 04:11:14.458359 ignition[953]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 04:11:14.463735 ignition[953]: INFO     : umount: umount passed
May 13 04:11:14.463735 ignition[953]: INFO     : Ignition finished successfully
May 13 04:11:14.461077 systemd[1]: ignition-mount.service: Deactivated successfully.
May 13 04:11:14.461191 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 13 04:11:14.461844 systemd[1]: ignition-disks.service: Deactivated successfully.
May 13 04:11:14.461887 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 13 04:11:14.464337 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 13 04:11:14.464378 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 13 04:11:14.464960 systemd[1]: ignition-fetch.service: Deactivated successfully.
May 13 04:11:14.465001 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
May 13 04:11:14.465574 systemd[1]: Stopped target network.target - Network.
May 13 04:11:14.466523 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 13 04:11:14.466566 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 13 04:11:14.468946 systemd[1]: Stopped target paths.target - Path Units.
May 13 04:11:14.471346 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 13 04:11:14.475338 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 04:11:14.476277 systemd[1]: Stopped target slices.target - Slice Units.
May 13 04:11:14.476752 systemd[1]: Stopped target sockets.target - Socket Units.
May 13 04:11:14.477314 systemd[1]: iscsid.socket: Deactivated successfully.
May 13 04:11:14.477350 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 13 04:11:14.477831 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 13 04:11:14.477862 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 13 04:11:14.478398 systemd[1]: ignition-setup.service: Deactivated successfully.
May 13 04:11:14.478441 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 13 04:11:14.479623 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 13 04:11:14.479664 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 13 04:11:14.481061 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 13 04:11:14.482354 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 13 04:11:14.484550 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 13 04:11:14.485097 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 13 04:11:14.485181 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 13 04:11:14.485302 systemd-networkd[708]: eth0: DHCPv6 lease lost
May 13 04:11:14.487766 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 13 04:11:14.488422 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 13 04:11:14.489998 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 13 04:11:14.490127 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 13 04:11:14.492892 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 13 04:11:14.493297 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 13 04:11:14.494006 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 13 04:11:14.494051 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 13 04:11:14.502509 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 13 04:11:14.503042 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 13 04:11:14.503096 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 13 04:11:14.503711 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 13 04:11:14.503754 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 13 04:11:14.504846 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 13 04:11:14.504887 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 13 04:11:14.506025 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 13 04:11:14.506065 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 04:11:14.507460 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 04:11:14.521555 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 13 04:11:14.522289 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 04:11:14.523267 systemd[1]: network-cleanup.service: Deactivated successfully.
May 13 04:11:14.523346 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 13 04:11:14.524636 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 13 04:11:14.524693 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 13 04:11:14.525928 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 13 04:11:14.525959 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 04:11:14.527096 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 13 04:11:14.527139 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 13 04:11:14.528742 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 13 04:11:14.528783 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 13 04:11:14.529990 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 13 04:11:14.530030 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 04:11:14.536588 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 13 04:11:14.537164 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 13 04:11:14.537259 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 04:11:14.537827 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
May 13 04:11:14.537869 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 04:11:14.538485 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 13 04:11:14.538526 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 04:11:14.539720 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 04:11:14.539760 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:14.545143 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 13 04:11:14.545390 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 13 04:11:14.546510 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 13 04:11:14.553630 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 13 04:11:14.561512 systemd[1]: Switching root.
May 13 04:11:14.594683 systemd-journald[185]: Journal stopped
May 13 04:11:15.690962 systemd-journald[185]: Received SIGTERM from PID 1 (systemd).
May 13 04:11:15.691028 kernel: SELinux:  policy capability network_peer_controls=1
May 13 04:11:15.691047 kernel: SELinux:  policy capability open_perms=1
May 13 04:11:15.691058 kernel: SELinux:  policy capability extended_socket_class=1
May 13 04:11:15.691069 kernel: SELinux:  policy capability always_check_network=0
May 13 04:11:15.691081 kernel: SELinux:  policy capability cgroup_seclabel=1
May 13 04:11:15.691092 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 13 04:11:15.691103 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 13 04:11:15.691115 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 13 04:11:15.691128 kernel: audit: type=1403 audit(1747109474.739:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 13 04:11:15.691141 systemd[1]: Successfully loaded SELinux policy in 78.441ms.
May 13 04:11:15.691166 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.736ms.
May 13 04:11:15.691179 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
May 13 04:11:15.691191 systemd[1]: Detected virtualization kvm.
May 13 04:11:15.691203 systemd[1]: Detected architecture x86-64.
May 13 04:11:15.691236 systemd[1]: Detected first boot.
May 13 04:11:15.691250 systemd[1]: Hostname set to <ci-4081-3-3-n-300cc17afe.novalocal>.
May 13 04:11:15.691264 systemd[1]: Initializing machine ID from VM UUID.
May 13 04:11:15.691276 zram_generator::config[995]: No configuration found.
May 13 04:11:15.691288 systemd[1]: Populated /etc with preset unit settings.
May 13 04:11:15.691300 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 13 04:11:15.691312 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 13 04:11:15.691324 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 13 04:11:15.691337 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 13 04:11:15.691349 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 13 04:11:15.691363 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 13 04:11:15.691377 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 13 04:11:15.691389 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 13 04:11:15.691401 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 13 04:11:15.691414 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 13 04:11:15.691426 systemd[1]: Created slice user.slice - User and Session Slice.
May 13 04:11:15.691440 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 04:11:15.691452 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 04:11:15.691465 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 13 04:11:15.691476 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 13 04:11:15.691488 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 13 04:11:15.691500 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 13 04:11:15.691512 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 13 04:11:15.691524 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 04:11:15.691536 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 13 04:11:15.691550 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 13 04:11:15.691562 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 13 04:11:15.691574 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 13 04:11:15.691586 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 04:11:15.691598 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 13 04:11:15.691610 systemd[1]: Reached target slices.target - Slice Units.
May 13 04:11:15.691624 systemd[1]: Reached target swap.target - Swaps.
May 13 04:11:15.691635 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 13 04:11:15.691647 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 13 04:11:15.691659 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 13 04:11:15.691672 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 13 04:11:15.691684 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 04:11:15.691696 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 13 04:11:15.691707 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 13 04:11:15.691719 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 13 04:11:15.691733 systemd[1]: Mounting media.mount - External Media Directory...
May 13 04:11:15.691745 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:15.691757 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 13 04:11:15.691769 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 13 04:11:15.691780 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 13 04:11:15.691793 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
May 13 04:11:15.691804 systemd[1]: Reached target machines.target - Containers.
May 13 04:11:15.691816 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 13 04:11:15.691830 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 04:11:15.691842 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 13 04:11:15.691854 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 13 04:11:15.691866 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 13 04:11:15.691877 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 13 04:11:15.691889 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 13 04:11:15.691901 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 13 04:11:15.691914 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 13 04:11:15.691927 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 13 04:11:15.691941 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 13 04:11:15.691952 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 13 04:11:15.691964 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 13 04:11:15.691976 systemd[1]: Stopped systemd-fsck-usr.service.
May 13 04:11:15.691992 kernel: loop: module loaded
May 13 04:11:15.692004 systemd[1]: Starting systemd-journald.service - Journal Service...
May 13 04:11:15.692015 kernel: fuse: init (API version 7.39)
May 13 04:11:15.692027 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 13 04:11:15.692038 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 13 04:11:15.692053 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 13 04:11:15.692080 systemd-journald[1098]: Collecting audit messages is disabled.
May 13 04:11:15.692107 systemd-journald[1098]: Journal started
May 13 04:11:15.692132 systemd-journald[1098]: Runtime Journal (/run/log/journal/1eb6c995cc8a4b4686108dfa5150f200) is 8.0M, max 78.3M, 70.3M free.
May 13 04:11:15.353280 systemd[1]: Queued start job for default target multi-user.target.
May 13 04:11:15.375765 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
May 13 04:11:15.376123 systemd[1]: systemd-journald.service: Deactivated successfully.
May 13 04:11:15.700254 kernel: ACPI: bus type drm_connector registered
May 13 04:11:15.706242 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 13 04:11:15.708271 systemd[1]: verity-setup.service: Deactivated successfully.
May 13 04:11:15.713086 systemd[1]: Stopped verity-setup.service.
May 13 04:11:15.713121 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:15.716234 systemd[1]: Started systemd-journald.service - Journal Service.
May 13 04:11:15.717361 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 13 04:11:15.718014 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 13 04:11:15.718694 systemd[1]: Mounted media.mount - External Media Directory.
May 13 04:11:15.719356 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 13 04:11:15.720000 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 13 04:11:15.720686 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 13 04:11:15.721567 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 13 04:11:15.722462 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 04:11:15.723306 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 13 04:11:15.723493 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 13 04:11:15.724340 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 13 04:11:15.724521 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 13 04:11:15.725478 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 13 04:11:15.725666 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 13 04:11:15.726496 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 13 04:11:15.726672 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 13 04:11:15.727554 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 13 04:11:15.727729 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 13 04:11:15.728514 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 13 04:11:15.728694 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 13 04:11:15.729557 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 13 04:11:15.730473 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 13 04:11:15.731297 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 13 04:11:15.741697 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 13 04:11:15.748068 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 13 04:11:15.752299 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 13 04:11:15.753317 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 13 04:11:15.753419 systemd[1]: Reached target local-fs.target - Local File Systems.
May 13 04:11:15.756510 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink).
May 13 04:11:15.766713 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 13 04:11:15.772032 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 13 04:11:15.772699 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 04:11:15.779460 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 13 04:11:15.785432 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 13 04:11:15.786102 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 13 04:11:15.789360 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 13 04:11:15.789982 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 13 04:11:15.795459 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 13 04:11:15.797603 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 13 04:11:15.801357 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 13 04:11:15.805802 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 04:11:15.806667 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 13 04:11:15.807299 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 13 04:11:15.808633 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 13 04:11:15.819324 systemd-journald[1098]: Time spent on flushing to /var/log/journal/1eb6c995cc8a4b4686108dfa5150f200 is 48.347ms for 923 entries.
May 13 04:11:15.819324 systemd-journald[1098]: System Journal (/var/log/journal/1eb6c995cc8a4b4686108dfa5150f200) is 8.0M, max 584.8M, 576.8M free.
May 13 04:11:15.883419 systemd-journald[1098]: Received client request to flush runtime journal.
May 13 04:11:15.883486 kernel: loop0: detected capacity change from 0 to 140768
May 13 04:11:15.826249 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
May 13 04:11:15.836883 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 13 04:11:15.838071 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 13 04:11:15.852395 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk...
May 13 04:11:15.860382 udevadm[1134]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
May 13 04:11:15.885530 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 13 04:11:15.927403 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 13 04:11:15.928103 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 13 04:11:15.943026 systemd-tmpfiles[1129]: ACLs are not supported, ignoring.
May 13 04:11:15.943043 systemd-tmpfiles[1129]: ACLs are not supported, ignoring.
May 13 04:11:15.943970 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 13 04:11:15.947939 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk.
May 13 04:11:15.951433 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 04:11:15.957438 kernel: loop1: detected capacity change from 0 to 8
May 13 04:11:15.961529 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 13 04:11:15.986238 kernel: loop2: detected capacity change from 0 to 142488
May 13 04:11:16.017056 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 13 04:11:16.025180 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 13 04:11:16.047906 systemd-tmpfiles[1153]: ACLs are not supported, ignoring.
May 13 04:11:16.047926 systemd-tmpfiles[1153]: ACLs are not supported, ignoring.
May 13 04:11:16.052569 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 04:11:16.063258 kernel: loop3: detected capacity change from 0 to 140768
May 13 04:11:16.100239 kernel: loop4: detected capacity change from 0 to 8
May 13 04:11:16.103232 kernel: loop5: detected capacity change from 0 to 142488
May 13 04:11:16.169602 (sd-merge)[1157]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'.
May 13 04:11:16.170010 (sd-merge)[1157]: Merged extensions into '/usr'.
May 13 04:11:16.179529 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 13 04:11:16.188442 systemd[1]: Starting ensure-sysext.service...
May 13 04:11:16.197400 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 13 04:11:16.210921 systemd[1]: Reloading requested from client PID 1159 ('systemctl') (unit ensure-sysext.service)...
May 13 04:11:16.211069 systemd[1]: Reloading...
May 13 04:11:16.232655 systemd-tmpfiles[1160]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 13 04:11:16.234920 systemd-tmpfiles[1160]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 13 04:11:16.240570 systemd-tmpfiles[1160]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 13 04:11:16.243230 systemd-tmpfiles[1160]: ACLs are not supported, ignoring.
May 13 04:11:16.243309 systemd-tmpfiles[1160]: ACLs are not supported, ignoring.
May 13 04:11:16.254539 systemd-tmpfiles[1160]: Detected autofs mount point /boot during canonicalization of boot.
May 13 04:11:16.254552 systemd-tmpfiles[1160]: Skipping /boot
May 13 04:11:16.284801 systemd-tmpfiles[1160]: Detected autofs mount point /boot during canonicalization of boot.
May 13 04:11:16.284814 systemd-tmpfiles[1160]: Skipping /boot
May 13 04:11:16.305284 zram_generator::config[1184]: No configuration found.
May 13 04:11:16.547428 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
May 13 04:11:16.618996 systemd[1]: Reloading finished in 407 ms.
May 13 04:11:16.655558 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 04:11:16.663363 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
May 13 04:11:16.680393 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 13 04:11:16.682278 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 13 04:11:16.686493 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 13 04:11:16.692447 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 13 04:11:16.704445 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.704777 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 04:11:16.714638 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 13 04:11:16.723881 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 13 04:11:16.731503 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 13 04:11:16.732605 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 04:11:16.732747 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.740494 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 13 04:11:16.743706 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.743877 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 04:11:16.744035 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 04:11:16.744136 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.747739 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.747947 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 04:11:16.755517 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 13 04:11:16.757424 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 04:11:16.757595 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 04:11:16.761617 systemd[1]: Finished ensure-sysext.service.
May 13 04:11:16.774512 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
May 13 04:11:16.776579 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 13 04:11:16.788253 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 13 04:11:16.788962 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 13 04:11:16.790387 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 13 04:11:16.790663 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 13 04:11:16.796601 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 13 04:11:16.799682 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 13 04:11:16.799827 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 13 04:11:16.800775 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 13 04:11:16.800897 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 13 04:11:16.804435 ldconfig[1123]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 13 04:11:16.811377 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 13 04:11:16.811562 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 13 04:11:16.819337 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 04:11:16.820479 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 13 04:11:16.829122 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 13 04:11:16.839517 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 13 04:11:16.851737 augenrules[1282]: No rules
May 13 04:11:16.854888 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 13 04:11:16.857241 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
May 13 04:11:16.863431 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 13 04:11:16.885390 systemd-udevd[1275]: Using default interface naming scheme 'v255'.
May 13 04:11:16.902522 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 13 04:11:16.903471 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
May 13 04:11:16.932350 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 04:11:16.942423 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 13 04:11:16.943058 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
May 13 04:11:16.944155 systemd[1]: Reached target time-set.target - System Time Set.
May 13 04:11:16.973874 systemd-resolved[1250]: Positive Trust Anchors:
May 13 04:11:16.973894 systemd-resolved[1250]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 13 04:11:16.973940 systemd-resolved[1250]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 13 04:11:16.980901 systemd-resolved[1250]: Using system hostname 'ci-4081-3-3-n-300cc17afe.novalocal'.
May 13 04:11:16.982676 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 13 04:11:16.983346 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 13 04:11:17.004890 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 13 04:11:17.021683 systemd-networkd[1299]: lo: Link UP
May 13 04:11:17.023150 systemd-networkd[1299]: lo: Gained carrier
May 13 04:11:17.023826 systemd-networkd[1299]: Enumeration completed
May 13 04:11:17.024062 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 13 04:11:17.024812 systemd[1]: Reached target network.target - Network.
May 13 04:11:17.030639 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 13 04:11:17.093271 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1314)
May 13 04:11:17.109869 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
May 13 04:11:17.113383 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
May 13 04:11:17.120427 kernel: ACPI: button: Power Button [PWRF]
May 13 04:11:17.143258 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
May 13 04:11:17.159134 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 13 04:11:17.172381 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 13 04:11:17.176529 systemd-networkd[1299]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 04:11:17.176538 systemd-networkd[1299]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 13 04:11:17.178156 systemd-networkd[1299]: eth0: Link UP
May 13 04:11:17.178165 systemd-networkd[1299]: eth0: Gained carrier
May 13 04:11:17.178187 systemd-networkd[1299]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 04:11:17.196324 systemd-networkd[1299]: eth0: DHCPv4 address 172.24.4.202/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 13 04:11:17.197289 systemd-timesyncd[1263]: Network configuration changed, trying to establish connection.
May 13 04:11:17.198501 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 04:11:17.207484 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 13 04:11:17.213249 kernel: mousedev: PS/2 mouse device common for all mice
May 13 04:11:17.225240 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0
May 13 04:11:17.227478 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console
May 13 04:11:17.232029 kernel: Console: switching to colour dummy device 80x25
May 13 04:11:17.236101 kernel: [drm] features: -virgl +edid -resource_blob -host_visible
May 13 04:11:17.236135 kernel: [drm] features: -context_init
May 13 04:11:17.239230 kernel: [drm] number of scanouts: 1
May 13 04:11:17.240235 kernel: [drm] number of cap sets: 0
May 13 04:11:17.243277 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:02.0 on minor 0
May 13 04:11:17.252441 kernel: fbcon: virtio_gpudrmfb (fb0) is primary device
May 13 04:11:17.252529 kernel: Console: switching to colour frame buffer device 160x50
May 13 04:11:17.261636 kernel: virtio-pci 0000:00:02.0: [drm] fb0: virtio_gpudrmfb frame buffer device
May 13 04:11:17.262864 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 04:11:17.263086 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:17.268351 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 04:11:17.270388 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
May 13 04:11:17.282365 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
May 13 04:11:17.303083 lvm[1340]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 13 04:11:17.337287 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
May 13 04:11:17.338142 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 13 04:11:17.346587 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
May 13 04:11:17.365351 lvm[1345]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 13 04:11:17.376670 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 04:11:17.378109 systemd[1]: Reached target sysinit.target - System Initialization.
May 13 04:11:17.380696 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 13 04:11:17.381013 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
May 13 04:11:17.382083 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 13 04:11:17.382758 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 13 04:11:17.383196 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 13 04:11:17.383875 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 13 04:11:17.383939 systemd[1]: Reached target paths.target - Path Units.
May 13 04:11:17.384077 systemd[1]: Reached target timers.target - Timer Units.
May 13 04:11:17.385693 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 13 04:11:17.388131 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 13 04:11:17.397899 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 13 04:11:17.399604 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 13 04:11:17.400772 systemd[1]: Reached target sockets.target - Socket Units.
May 13 04:11:17.400860 systemd[1]: Reached target basic.target - Basic System.
May 13 04:11:17.400982 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 13 04:11:17.401006 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 13 04:11:17.402258 systemd[1]: Starting containerd.service - containerd container runtime...
May 13 04:11:17.410396 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
May 13 04:11:17.421390 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 13 04:11:17.425145 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 13 04:11:17.430443 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 13 04:11:17.437254 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment).
May 13 04:11:17.439268 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 13 04:11:17.445053 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 13 04:11:17.454246 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 13 04:11:17.466493 systemd[1]: Starting systemd-logind.service - User Login Management...
May 13 04:11:17.469061 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 13 04:11:17.469563 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 13 04:11:17.473924 extend-filesystems[1354]: Found loop3
May 13 04:11:17.478054 extend-filesystems[1354]: Found loop4
May 13 04:11:17.478054 extend-filesystems[1354]: Found loop5
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda1
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda2
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda3
May 13 04:11:17.478054 extend-filesystems[1354]: Found usr
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda4
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda6
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda7
May 13 04:11:17.478054 extend-filesystems[1354]: Found vda9
May 13 04:11:17.478054 extend-filesystems[1354]: Checking size of /dev/vda9
May 13 04:11:17.477701 dbus-daemon[1352]: [system] SELinux support is enabled
May 13 04:11:17.529707 jq[1353]: false
May 13 04:11:17.479476 systemd[1]: Starting update-engine.service - Update Engine...
May 13 04:11:17.492408 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 13 04:11:17.500770 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 13 04:11:17.507641 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
May 13 04:11:17.530322 jq[1367]: true
May 13 04:11:17.529600 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 13 04:11:17.529773 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 13 04:11:17.539960 extend-filesystems[1354]: Resized partition /dev/vda9
May 13 04:11:17.552102 extend-filesystems[1381]: resize2fs 1.47.1 (20-May-2024)
May 13 04:11:17.543692 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml).
May 13 04:11:17.543724 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 13 04:11:17.550600 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
May 13 04:11:17.550622 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 13 04:11:17.555265 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 13 04:11:17.555438 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 13 04:11:17.569261 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 2014203 blocks
May 13 04:11:17.574610 systemd[1]: motdgen.service: Deactivated successfully.
May 13 04:11:17.574773 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 13 04:11:17.577364 jq[1376]: true
May 13 04:11:17.590266 kernel: EXT4-fs (vda9): resized filesystem to 2014203
May 13 04:11:17.591089 (ntainerd)[1383]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 13 04:11:17.657031 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1316)
May 13 04:11:17.657722 update_engine[1364]: I20250513 04:11:17.591610  1364 main.cc:92] Flatcar Update Engine starting
May 13 04:11:17.657722 update_engine[1364]: I20250513 04:11:17.603454  1364 update_check_scheduler.cc:74] Next update check in 11m57s
May 13 04:11:17.596236 systemd[1]: Started update-engine.service - Update Engine.
May 13 04:11:17.609593 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 13 04:11:17.650989 systemd-logind[1362]: New seat seat0.
May 13 04:11:17.657847 systemd-logind[1362]: Watching system buttons on /dev/input/event1 (Power Button)
May 13 04:11:17.657866 systemd-logind[1362]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 13 04:11:17.658301 systemd[1]: Started systemd-logind.service - User Login Management.
May 13 04:11:17.667405 extend-filesystems[1381]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required
May 13 04:11:17.667405 extend-filesystems[1381]: old_desc_blocks = 1, new_desc_blocks = 1
May 13 04:11:17.667405 extend-filesystems[1381]: The filesystem on /dev/vda9 is now 2014203 (4k) blocks long.
May 13 04:11:17.675349 extend-filesystems[1354]: Resized filesystem in /dev/vda9
May 13 04:11:17.668779 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 13 04:11:17.669590 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 13 04:11:17.721703 bash[1405]: Updated "/home/core/.ssh/authorized_keys"
May 13 04:11:17.723551 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 13 04:11:17.733492 systemd[1]: Starting sshkeys.service...
May 13 04:11:17.760123 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys.
May 13 04:11:17.770619 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)...
May 13 04:11:17.791613 locksmithd[1389]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 13 04:11:17.845748 sshd_keygen[1391]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 13 04:11:17.867365 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 13 04:11:17.880520 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 13 04:11:17.892579 systemd[1]: issuegen.service: Deactivated successfully.
May 13 04:11:17.892874 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 13 04:11:17.908623 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 13 04:11:17.924016 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 13 04:11:17.936626 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 13 04:11:17.943449 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 13 04:11:17.946645 systemd[1]: Reached target getty.target - Login Prompts.
May 13 04:11:17.978907 containerd[1383]: time="2025-05-13T04:11:17.978791399Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21
May 13 04:11:18.006550 containerd[1383]: time="2025-05-13T04:11:18.006397705Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009281744Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009515562Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009550508Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009782463Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009820815Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009905053Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.009972249Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.010178846Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.010204845Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.010256812Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
May 13 04:11:18.011083 containerd[1383]: time="2025-05-13T04:11:18.010279144Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010372299Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010593604Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010722165Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010748284Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010857890Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
May 13 04:11:18.011418 containerd[1383]: time="2025-05-13T04:11:18.010925276Z" level=info msg="metadata content store policy set" policy=shared
May 13 04:11:18.018261 containerd[1383]: time="2025-05-13T04:11:18.018230557Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
May 13 04:11:18.018494 containerd[1383]: time="2025-05-13T04:11:18.018368336Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
May 13 04:11:18.018494 containerd[1383]: time="2025-05-13T04:11:18.018413761Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
May 13 04:11:18.018494 containerd[1383]: time="2025-05-13T04:11:18.018435031Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
May 13 04:11:18.018494 containerd[1383]: time="2025-05-13T04:11:18.018456090Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
May 13 04:11:18.019123 containerd[1383]: time="2025-05-13T04:11:18.018750162Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
May 13 04:11:18.019123 containerd[1383]: time="2025-05-13T04:11:18.019046297Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019142938Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019163377Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019189075Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019225694Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019256932Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019272912Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019302938Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019321383Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019337343Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019351810Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019360 containerd[1383]: time="2025-05-13T04:11:18.019364604Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019387517Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019405320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019419898Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019436689Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019451417Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019471264Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019485521Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019499667Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019514966Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019532659Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019546445Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019563247Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019577584Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019595277Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
May 13 04:11:18.019923 containerd[1383]: time="2025-05-13T04:11:18.019617478Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019631615Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019643738Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019699973Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019719710Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019732614Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019747612Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019760296Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019777238Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019789090Z" level=info msg="NRI interface is disabled by configuration."
May 13 04:11:18.020693 containerd[1383]: time="2025-05-13T04:11:18.019800101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
May 13 04:11:18.022105 systemd[1]: Started containerd.service - containerd container runtime.
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.020091708Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.020162631Z" level=info msg="Connect containerd service"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.020196364Z" level=info msg="using legacy CRI server"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.020203908Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.020353869Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021203363Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021426792Z" level=info msg="Start subscribing containerd event"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021557828Z" level=info msg="Start recovering state"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021616077Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021692871Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021701988Z" level=info msg="Start event monitor"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021787508Z" level=info msg="Start snapshots syncer"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021818847Z" level=info msg="Start cni network conf syncer for default"
May 13 04:11:18.022839 containerd[1383]: time="2025-05-13T04:11:18.021838965Z" level=info msg="Start streaming server"
May 13 04:11:18.028992 containerd[1383]: time="2025-05-13T04:11:18.028468909Z" level=info msg="containerd successfully booted in 0.050987s"
May 13 04:11:18.044088 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 13 04:11:18.059070 systemd[1]: Started sshd@0-172.24.4.202:22-172.24.4.1:50236.service - OpenSSH per-connection server daemon (172.24.4.1:50236).
May 13 04:11:19.030032 sshd[1442]: Accepted publickey for core from 172.24.4.1 port 50236 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:19.034467 sshd[1442]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:19.058846 systemd-logind[1362]: New session 1 of user core.
May 13 04:11:19.063117 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 13 04:11:19.079713 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 13 04:11:19.108442 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 13 04:11:19.115341 systemd-networkd[1299]: eth0: Gained IPv6LL
May 13 04:11:19.116687 systemd-timesyncd[1263]: Network configuration changed, trying to establish connection.
May 13 04:11:19.124906 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 13 04:11:19.132694 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 13 04:11:19.141556 systemd[1]: Reached target network-online.target - Network is Online.
May 13 04:11:19.149700 (systemd)[1448]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 13 04:11:19.157860 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 13 04:11:19.196633 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 13 04:11:19.294968 systemd[1448]: Queued start job for default target default.target.
May 13 04:11:19.302082 systemd[1448]: Created slice app.slice - User Application Slice.
May 13 04:11:19.302111 systemd[1448]: Reached target paths.target - Paths.
May 13 04:11:19.302126 systemd[1448]: Reached target timers.target - Timers.
May 13 04:11:19.303447 systemd[1448]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 13 04:11:19.323990 systemd[1448]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 13 04:11:19.324112 systemd[1448]: Reached target sockets.target - Sockets.
May 13 04:11:19.324128 systemd[1448]: Reached target basic.target - Basic System.
May 13 04:11:19.324164 systemd[1448]: Reached target default.target - Main User Target.
May 13 04:11:19.324190 systemd[1448]: Startup finished in 145ms.
May 13 04:11:19.324310 systemd[1]: Started user@500.service - User Manager for UID 500.
May 13 04:11:19.334644 systemd[1]: Started session-1.scope - Session 1 of User core.
May 13 04:11:19.827977 systemd[1]: Started sshd@1-172.24.4.202:22-172.24.4.1:50250.service - OpenSSH per-connection server daemon (172.24.4.1:50250).
May 13 04:11:21.371571 sshd[1468]: Accepted publickey for core from 172.24.4.1 port 50250 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:21.374429 sshd[1468]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:21.383986 systemd-logind[1362]: New session 2 of user core.
May 13 04:11:21.395661 systemd[1]: Started session-2.scope - Session 2 of User core.
May 13 04:11:22.014198 sshd[1468]: pam_unix(sshd:session): session closed for user core
May 13 04:11:22.026352 systemd[1]: sshd@1-172.24.4.202:22-172.24.4.1:50250.service: Deactivated successfully.
May 13 04:11:22.029537 systemd[1]: session-2.scope: Deactivated successfully.
May 13 04:11:22.032954 systemd-logind[1362]: Session 2 logged out. Waiting for processes to exit.
May 13 04:11:22.039487 systemd[1]: Started sshd@2-172.24.4.202:22-172.24.4.1:50264.service - OpenSSH per-connection server daemon (172.24.4.1:50264).
May 13 04:11:22.054501 systemd-logind[1362]: Removed session 2.
May 13 04:11:22.987923 login[1435]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 13 04:11:22.998736 systemd-logind[1362]: New session 3 of user core.
May 13 04:11:23.006332 login[1436]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 13 04:11:23.012886 systemd[1]: Started session-3.scope - Session 3 of User core.
May 13 04:11:23.026676 systemd-logind[1362]: New session 4 of user core.
May 13 04:11:23.038651 systemd[1]: Started session-4.scope - Session 4 of User core.
May 13 04:11:23.194123 sshd[1477]: Accepted publickey for core from 172.24.4.1 port 50264 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:23.196881 sshd[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:23.206830 systemd-logind[1362]: New session 5 of user core.
May 13 04:11:23.218768 systemd[1]: Started session-5.scope - Session 5 of User core.
May 13 04:11:23.788800 sshd[1477]: pam_unix(sshd:session): session closed for user core
May 13 04:11:23.795078 systemd[1]: sshd@2-172.24.4.202:22-172.24.4.1:50264.service: Deactivated successfully.
May 13 04:11:23.799101 systemd[1]: session-5.scope: Deactivated successfully.
May 13 04:11:23.802528 systemd-logind[1362]: Session 5 logged out. Waiting for processes to exit.
May 13 04:11:23.805182 systemd-logind[1362]: Removed session 5.
May 13 04:11:24.521785 coreos-metadata[1351]: May 13 04:11:24.521 WARN failed to locate config-drive, using the metadata service API instead
May 13 04:11:24.569308 coreos-metadata[1351]: May 13 04:11:24.569 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1
May 13 04:11:24.855787 coreos-metadata[1412]: May 13 04:11:24.855 WARN failed to locate config-drive, using the metadata service API instead
May 13 04:11:24.889548 coreos-metadata[1412]: May 13 04:11:24.889 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1
May 13 04:11:24.990369 coreos-metadata[1351]: May 13 04:11:24.990 INFO Fetch successful
May 13 04:11:24.990369 coreos-metadata[1351]: May 13 04:11:24.990 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 13 04:11:25.006488 coreos-metadata[1351]: May 13 04:11:25.006 INFO Fetch successful
May 13 04:11:25.006488 coreos-metadata[1351]: May 13 04:11:25.006 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1
May 13 04:11:25.020560 coreos-metadata[1351]: May 13 04:11:25.020 INFO Fetch successful
May 13 04:11:25.020560 coreos-metadata[1351]: May 13 04:11:25.020 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1
May 13 04:11:25.035666 coreos-metadata[1351]: May 13 04:11:25.035 INFO Fetch successful
May 13 04:11:25.035666 coreos-metadata[1351]: May 13 04:11:25.035 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1
May 13 04:11:25.049273 coreos-metadata[1351]: May 13 04:11:25.049 INFO Fetch successful
May 13 04:11:25.049273 coreos-metadata[1351]: May 13 04:11:25.049 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1
May 13 04:11:25.063012 coreos-metadata[1351]: May 13 04:11:25.062 INFO Fetch successful
May 13 04:11:25.118524 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
May 13 04:11:25.120313 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 13 04:11:25.212146 coreos-metadata[1412]: May 13 04:11:25.212 INFO Fetch successful
May 13 04:11:25.212146 coreos-metadata[1412]: May 13 04:11:25.212 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1
May 13 04:11:25.225766 coreos-metadata[1412]: May 13 04:11:25.225 INFO Fetch successful
May 13 04:11:25.231263 unknown[1412]: wrote ssh authorized keys file for user: core
May 13 04:11:25.272775 update-ssh-keys[1518]: Updated "/home/core/.ssh/authorized_keys"
May 13 04:11:25.273740 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys).
May 13 04:11:25.277057 systemd[1]: Finished sshkeys.service.
May 13 04:11:25.282009 systemd[1]: Reached target multi-user.target - Multi-User System.
May 13 04:11:25.282411 systemd[1]: Startup finished in 1.210s (kernel) + 11.908s (initrd) + 10.619s (userspace) = 23.738s.
May 13 04:11:33.813657 systemd[1]: Started sshd@3-172.24.4.202:22-172.24.4.1:39680.service - OpenSSH per-connection server daemon (172.24.4.1:39680).
May 13 04:11:35.339055 sshd[1523]: Accepted publickey for core from 172.24.4.1 port 39680 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:35.342298 sshd[1523]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:35.354316 systemd-logind[1362]: New session 6 of user core.
May 13 04:11:35.366629 systemd[1]: Started session-6.scope - Session 6 of User core.
May 13 04:11:36.162153 sshd[1523]: pam_unix(sshd:session): session closed for user core
May 13 04:11:36.176439 systemd[1]: sshd@3-172.24.4.202:22-172.24.4.1:39680.service: Deactivated successfully.
May 13 04:11:36.180062 systemd[1]: session-6.scope: Deactivated successfully.
May 13 04:11:36.182347 systemd-logind[1362]: Session 6 logged out. Waiting for processes to exit.
May 13 04:11:36.191004 systemd[1]: Started sshd@4-172.24.4.202:22-172.24.4.1:39694.service - OpenSSH per-connection server daemon (172.24.4.1:39694).
May 13 04:11:36.194359 systemd-logind[1362]: Removed session 6.
May 13 04:11:37.464362 sshd[1530]: Accepted publickey for core from 172.24.4.1 port 39694 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:37.467070 sshd[1530]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:37.476452 systemd-logind[1362]: New session 7 of user core.
May 13 04:11:37.489500 systemd[1]: Started session-7.scope - Session 7 of User core.
May 13 04:11:38.106674 sshd[1530]: pam_unix(sshd:session): session closed for user core
May 13 04:11:38.118183 systemd[1]: sshd@4-172.24.4.202:22-172.24.4.1:39694.service: Deactivated successfully.
May 13 04:11:38.121842 systemd[1]: session-7.scope: Deactivated successfully.
May 13 04:11:38.124027 systemd-logind[1362]: Session 7 logged out. Waiting for processes to exit.
May 13 04:11:38.133020 systemd[1]: Started sshd@5-172.24.4.202:22-172.24.4.1:39696.service - OpenSSH per-connection server daemon (172.24.4.1:39696).
May 13 04:11:38.136340 systemd-logind[1362]: Removed session 7.
May 13 04:11:39.282546 sshd[1537]: Accepted publickey for core from 172.24.4.1 port 39696 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:39.285395 sshd[1537]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:39.297332 systemd-logind[1362]: New session 8 of user core.
May 13 04:11:39.307549 systemd[1]: Started session-8.scope - Session 8 of User core.
May 13 04:11:39.923285 sshd[1537]: pam_unix(sshd:session): session closed for user core
May 13 04:11:39.939542 systemd[1]: sshd@5-172.24.4.202:22-172.24.4.1:39696.service: Deactivated successfully.
May 13 04:11:39.943481 systemd[1]: session-8.scope: Deactivated successfully.
May 13 04:11:39.947601 systemd-logind[1362]: Session 8 logged out. Waiting for processes to exit.
May 13 04:11:39.956027 systemd[1]: Started sshd@6-172.24.4.202:22-172.24.4.1:39706.service - OpenSSH per-connection server daemon (172.24.4.1:39706).
May 13 04:11:39.960351 systemd-logind[1362]: Removed session 8.
May 13 04:11:41.042099 sshd[1544]: Accepted publickey for core from 172.24.4.1 port 39706 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:41.045373 sshd[1544]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:41.057371 systemd-logind[1362]: New session 9 of user core.
May 13 04:11:41.066563 systemd[1]: Started session-9.scope - Session 9 of User core.
May 13 04:11:41.537665 sudo[1547]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
May 13 04:11:41.538627 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 13 04:11:41.557528 sudo[1547]: pam_unix(sudo:session): session closed for user root
May 13 04:11:41.777787 sshd[1544]: pam_unix(sshd:session): session closed for user core
May 13 04:11:41.792362 systemd[1]: sshd@6-172.24.4.202:22-172.24.4.1:39706.service: Deactivated successfully.
May 13 04:11:41.797896 systemd[1]: session-9.scope: Deactivated successfully.
May 13 04:11:41.802369 systemd-logind[1362]: Session 9 logged out. Waiting for processes to exit.
May 13 04:11:41.811023 systemd[1]: Started sshd@7-172.24.4.202:22-172.24.4.1:39718.service - OpenSSH per-connection server daemon (172.24.4.1:39718).
May 13 04:11:41.813510 systemd-logind[1362]: Removed session 9.
May 13 04:11:42.972250 sshd[1552]: Accepted publickey for core from 172.24.4.1 port 39718 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:42.975490 sshd[1552]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:42.985944 systemd-logind[1362]: New session 10 of user core.
May 13 04:11:42.999564 systemd[1]: Started session-10.scope - Session 10 of User core.
May 13 04:11:43.432092 sudo[1556]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules
May 13 04:11:43.433041 sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 13 04:11:43.441264 sudo[1556]: pam_unix(sudo:session): session closed for user root
May 13 04:11:43.453280 sudo[1555]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
May 13 04:11:43.454152 sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 13 04:11:43.488654 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules...
May 13 04:11:43.492466 auditctl[1559]: No rules
May 13 04:11:43.493467 systemd[1]: audit-rules.service: Deactivated successfully.
May 13 04:11:43.493940 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules.
May 13 04:11:43.505453 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
May 13 04:11:43.573752 augenrules[1577]: No rules
May 13 04:11:43.575100 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
May 13 04:11:43.578206 sudo[1555]: pam_unix(sudo:session): session closed for user root
May 13 04:11:43.748378 sshd[1552]: pam_unix(sshd:session): session closed for user core
May 13 04:11:43.762025 systemd[1]: sshd@7-172.24.4.202:22-172.24.4.1:39718.service: Deactivated successfully.
May 13 04:11:43.765715 systemd[1]: session-10.scope: Deactivated successfully.
May 13 04:11:43.769717 systemd-logind[1362]: Session 10 logged out. Waiting for processes to exit.
May 13 04:11:43.779091 systemd[1]: Started sshd@8-172.24.4.202:22-172.24.4.1:48566.service - OpenSSH per-connection server daemon (172.24.4.1:48566).
May 13 04:11:43.783547 systemd-logind[1362]: Removed session 10.
May 13 04:11:44.775557 sshd[1585]: Accepted publickey for core from 172.24.4.1 port 48566 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:44.778699 sshd[1585]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:44.789794 systemd-logind[1362]: New session 11 of user core.
May 13 04:11:44.799516 systemd[1]: Started session-11.scope - Session 11 of User core.
May 13 04:11:45.180428 sudo[1588]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir -p .
May 13 04:11:45.181877 sudo[1588]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 13 04:11:45.190326 sudo[1588]: pam_unix(sudo:session): session closed for user root
May 13 04:11:45.411326 sshd[1585]: pam_unix(sshd:session): session closed for user core
May 13 04:11:45.422892 systemd[1]: sshd@8-172.24.4.202:22-172.24.4.1:48566.service: Deactivated successfully.
May 13 04:11:45.426149 systemd[1]: session-11.scope: Deactivated successfully.
May 13 04:11:45.429613 systemd-logind[1362]: Session 11 logged out. Waiting for processes to exit.
May 13 04:11:45.434743 systemd[1]: Started sshd@9-172.24.4.202:22-172.24.4.1:48580.service - OpenSSH per-connection server daemon (172.24.4.1:48580).
May 13 04:11:45.439095 systemd-logind[1362]: Removed session 11.
May 13 04:11:46.599989 sshd[1593]: Accepted publickey for core from 172.24.4.1 port 48580 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:46.603165 sshd[1593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:46.615339 systemd-logind[1362]: New session 12 of user core.
May 13 04:11:46.623570 systemd[1]: Started session-12.scope - Session 12 of User core.
May 13 04:11:47.070640 sudo[1596]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/install -m 0755 /dev/stdin kolet
May 13 04:11:47.071323 sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 13 04:11:49.661786 systemd-timesyncd[1263]: Contacted time server 23.186.168.127:123 (2.flatcar.pool.ntp.org).
May 13 04:11:49.661906 systemd-timesyncd[1263]: Initial clock synchronization to Tue 2025-05-13 04:11:49.970734 UTC.
May 13 04:11:54.476634 sudo[1596]: pam_unix(sudo:session): session closed for user root
May 13 04:11:54.747511 sshd[1593]: pam_unix(sshd:session): session closed for user core
May 13 04:11:54.759911 systemd[1]: sshd@9-172.24.4.202:22-172.24.4.1:48580.service: Deactivated successfully.
May 13 04:11:54.763093 systemd[1]: session-12.scope: Deactivated successfully.
May 13 04:11:54.766859 systemd-logind[1362]: Session 12 logged out. Waiting for processes to exit.
May 13 04:11:54.773850 systemd[1]: Started sshd@10-172.24.4.202:22-172.24.4.1:38908.service - OpenSSH per-connection server daemon (172.24.4.1:38908).
May 13 04:11:54.777828 systemd-logind[1362]: Removed session 12.
May 13 04:11:55.792772 sshd[1601]: Accepted publickey for core from 172.24.4.1 port 38908 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:11:55.795572 sshd[1601]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:11:55.804509 systemd-logind[1362]: New session 13 of user core.
May 13 04:11:55.813521 systemd[1]: Started session-13.scope - Session 13 of User core.
May 13 04:11:56.315186 ntpdate[1612]: ntpdate 4.2.8p17@1.4004-o Mon May 12 22:09:52 UTC 2025 (1)
May 13 04:12:02.552369 update_engine[1364]: I20250513 04:12:02.551987  1364 update_attempter.cc:509] Updating boot flags...
May 13 04:12:02.613319 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1620)
May 13 04:12:02.675350 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1620)
May 13 04:12:02.716328 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1620)
May 13 04:12:03.258093 ntpdate[1612]: adjust time server 192.48.105.15 offset +0.056297 sec
May 13 04:12:03.401872 sshd[1601]: pam_unix(sshd:session): session closed for user core
May 13 04:12:03.414595 systemd[1]: sshd@10-172.24.4.202:22-172.24.4.1:38908.service: Deactivated successfully.
May 13 04:12:03.418003 systemd[1]: session-13.scope: Deactivated successfully.
May 13 04:12:03.422351 systemd-logind[1362]: Session 13 logged out. Waiting for processes to exit.
May 13 04:12:03.431776 systemd[1]: Started sshd@11-172.24.4.202:22-172.24.4.1:38916.service - OpenSSH per-connection server daemon (172.24.4.1:38916).
May 13 04:12:03.435018 systemd-logind[1362]: Removed session 13.
May 13 04:12:04.446368 sshd[1631]: Accepted publickey for core from 172.24.4.1 port 38916 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:12:04.448960 sshd[1631]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:12:04.459518 systemd-logind[1362]: New session 14 of user core.
May 13 04:12:04.471553 systemd[1]: Started session-14.scope - Session 14 of User core.
May 13 04:12:05.184493 sshd[1631]: pam_unix(sshd:session): session closed for user core
May 13 04:12:05.201465 systemd[1]: sshd@11-172.24.4.202:22-172.24.4.1:38916.service: Deactivated successfully.
May 13 04:12:05.204446 systemd[1]: session-14.scope: Deactivated successfully.
May 13 04:12:05.205973 systemd-logind[1362]: Session 14 logged out. Waiting for processes to exit.
May 13 04:12:05.217785 systemd[1]: Started sshd@12-172.24.4.202:22-172.24.4.1:42444.service - OpenSSH per-connection server daemon (172.24.4.1:42444).
May 13 04:12:05.220267 systemd-logind[1362]: Removed session 14.
May 13 04:12:06.356023 sshd[1644]: Accepted publickey for core from 172.24.4.1 port 42444 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:12:06.358771 sshd[1644]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:12:06.367870 systemd-logind[1362]: New session 15 of user core.
May 13 04:12:06.376579 systemd[1]: Started session-15.scope - Session 15 of User core.
May 13 04:12:07.079440 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 13 04:12:07.080827 (dockerd)[1659]: 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
May 13 04:12:07.668398 dockerd[1659]: time="2025-05-13T04:12:07.668309706Z" level=info msg="Starting up"
May 13 04:12:07.850595 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport1678638779-merged.mount: Deactivated successfully.
May 13 04:12:07.961934 dockerd[1659]: time="2025-05-13T04:12:07.961293744Z" level=info msg="Loading containers: start."
May 13 04:12:08.156279 kernel: Initializing XFRM netlink socket
May 13 04:12:08.254428 systemd-networkd[1299]: docker0: Link UP
May 13 04:12:08.280822 dockerd[1659]: time="2025-05-13T04:12:08.280647178Z" level=info msg="Loading containers: done."
May 13 04:12:08.318517 dockerd[1659]: time="2025-05-13T04:12:08.318407076Z" 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
May 13 04:12:08.318891 dockerd[1659]: time="2025-05-13T04:12:08.318605317Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0
May 13 04:12:08.318891 dockerd[1659]: time="2025-05-13T04:12:08.318822067Z" level=info msg="Daemon has completed initialization"
May 13 04:12:08.383893 dockerd[1659]: time="2025-05-13T04:12:08.383702748Z" level=info msg="API listen on /run/docker.sock"
May 13 04:12:08.384166 systemd[1]: Started docker.service - Docker Application Container Engine.
May 13 04:12:08.844159 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4286363297-merged.mount: Deactivated successfully.
May 13 04:12:10.789406 kernel: docker0: port 1(veth1f3af64) entered blocking state
May 13 04:12:10.789651 kernel: docker0: port 1(veth1f3af64) entered disabled state
May 13 04:12:10.795876 kernel: veth1f3af64: entered allmulticast mode
May 13 04:12:10.795986 kernel: veth1f3af64: entered promiscuous mode
May 13 04:12:10.799830 systemd-networkd[1299]: veth1f3af64: Link UP
May 13 04:12:11.035669 containerd[1383]: time="2025-05-13T04:12:11.035322164Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 13 04:12:11.035669 containerd[1383]: time="2025-05-13T04:12:11.035393143Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 13 04:12:11.035669 containerd[1383]: time="2025-05-13T04:12:11.035408890Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 04:12:11.035669 containerd[1383]: time="2025-05-13T04:12:11.035479899Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 04:12:11.067556 systemd[1]: Started docker-38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd.scope - libcontainer container 38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd.
May 13 04:12:11.153988 kernel: eth0: renamed from veth65deb6c
May 13 04:12:11.162787 kernel: docker0: port 1(veth1f3af64) entered blocking state
May 13 04:12:11.162841 kernel: docker0: port 1(veth1f3af64) entered forwarding state
May 13 04:12:11.162759 systemd-networkd[1299]: veth1f3af64: Gained carrier
May 13 04:12:11.163373 systemd-networkd[1299]: docker0: Gained carrier
May 13 04:12:12.424602 systemd-networkd[1299]: veth1f3af64: Gained IPv6LL
May 13 04:12:13.000590 systemd-networkd[1299]: docker0: Gained IPv6LL
May 13 04:12:14.219390 systemd[1]: docker-38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd.scope: Deactivated successfully.
May 13 04:12:14.255066 dockerd[1659]: time="2025-05-13T04:12:14.254177398Z" level=info msg="ignoring event" container=38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 13 04:12:14.255752 containerd[1383]: time="2025-05-13T04:12:14.254759881Z" level=info msg="shim disconnected" id=38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd namespace=moby
May 13 04:12:14.255752 containerd[1383]: time="2025-05-13T04:12:14.254817088Z" level=warning msg="cleaning up after shim disconnected" id=38868487dfc430529c797062fce5e828286b757965b85f993a25b7c5a8a8fcfd namespace=moby
May 13 04:12:14.255752 containerd[1383]: time="2025-05-13T04:12:14.254841752Z" level=info msg="cleaning up dead shim" namespace=moby
May 13 04:12:14.279963 containerd[1383]: time="2025-05-13T04:12:14.279750773Z" level=warning msg="cleanup warnings time=\"2025-05-13T04:12:14Z\" 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
May 13 04:12:14.293985 kernel: docker0: port 1(veth1f3af64) entered disabled state
May 13 04:12:14.294089 kernel: veth65deb6c: renamed from eth0
May 13 04:12:14.293453 systemd-networkd[1299]: veth1f3af64: Lost carrier
May 13 04:12:14.314980 systemd-networkd[1299]: veth1f3af64: Link DOWN
May 13 04:12:14.319310 kernel: docker0: port 1(veth1f3af64) entered disabled state
May 13 04:12:14.325014 kernel: veth1f3af64 (unregistering): left allmulticast mode
May 13 04:12:14.325125 kernel: veth1f3af64 (unregistering): left promiscuous mode
May 13 04:12:14.325174 kernel: docker0: port 1(veth1f3af64) entered disabled state
May 13 04:12:14.355881 systemd[1]: run-docker-netns-5ddc15aefd51.mount: Deactivated successfully.
May 13 04:12:14.363606 systemd[1]: var-lib-docker-overlay2-00c000e77e33982151b2b831afb643338d0b45a58703be7aaef8c17b2f252986-merged.mount: Deactivated successfully.
May 13 04:12:14.523556 sshd[1644]: pam_unix(sshd:session): session closed for user core
May 13 04:12:14.545508 systemd[1]: sshd@12-172.24.4.202:22-172.24.4.1:42444.service: Deactivated successfully.
May 13 04:12:14.548557 systemd[1]: session-15.scope: Deactivated successfully.
May 13 04:12:14.551570 systemd-logind[1362]: Session 15 logged out. Waiting for processes to exit.
May 13 04:12:14.558748 systemd[1]: Started sshd@13-172.24.4.202:22-172.24.4.1:44634.service - OpenSSH per-connection server daemon (172.24.4.1:44634).
May 13 04:12:14.562204 systemd-logind[1362]: Removed session 15.
May 13 04:12:15.304661 systemd-networkd[1299]: docker0: Lost carrier
May 13 04:12:15.565065 sshd[1880]: Accepted publickey for core from 172.24.4.1 port 44634 ssh2: RSA SHA256:SaG5MESIv/g0oWPZSlhItfSVTW88TTmUIzdugBL9u+Y
May 13 04:12:15.567721 sshd[1880]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 04:12:15.576825 systemd-logind[1362]: New session 16 of user core.
May 13 04:12:15.588523 systemd[1]: Started session-16.scope - Session 16 of User core.
May 13 04:12:16.213424 kernel: docker0: port 1(vethe13ae74) entered blocking state
May 13 04:12:16.213641 kernel: docker0: port 1(vethe13ae74) entered disabled state
May 13 04:12:16.216266 kernel: vethe13ae74: entered allmulticast mode
May 13 04:12:16.219324 kernel: vethe13ae74: entered promiscuous mode
May 13 04:12:16.221994 systemd-networkd[1299]: vethe13ae74: Link UP
May 13 04:12:16.225582 kernel: docker0: port 1(vethe13ae74) entered blocking state
May 13 04:12:16.225670 kernel: docker0: port 1(vethe13ae74) entered forwarding state
May 13 04:12:16.228628 kernel: docker0: port 1(vethe13ae74) entered disabled state
May 13 04:12:16.295268 containerd[1383]: time="2025-05-13T04:12:16.294738552Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 13 04:12:16.295951 containerd[1383]: time="2025-05-13T04:12:16.295284860Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 13 04:12:16.295951 containerd[1383]: time="2025-05-13T04:12:16.295340080Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 04:12:16.298300 containerd[1383]: time="2025-05-13T04:12:16.298230171Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 04:12:16.313371 systemd[1]: Started docker-e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5.scope - libcontainer container e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5.
May 13 04:12:16.378509 kernel: eth0: renamed from veth7717831
May 13 04:12:16.385375 kernel: docker0: port 1(vethe13ae74) entered blocking state
May 13 04:12:16.385415 kernel: docker0: port 1(vethe13ae74) entered forwarding state
May 13 04:12:16.385491 systemd-networkd[1299]: vethe13ae74: Gained carrier
May 13 04:12:16.385694 systemd-networkd[1299]: docker0: Gained carrier
May 13 04:12:16.417809 systemd[1]: docker-e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5.scope: Deactivated successfully.
May 13 04:12:16.438793 dockerd[1659]: time="2025-05-13T04:12:16.438753280Z" level=info msg="ignoring event" container=e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 13 04:12:16.439177 containerd[1383]: time="2025-05-13T04:12:16.439079514Z" level=info msg="shim disconnected" id=e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5 namespace=moby
May 13 04:12:16.439177 containerd[1383]: time="2025-05-13T04:12:16.439140270Z" level=warning msg="cleaning up after shim disconnected" id=e46e1b7a690bba5869ea911b29531a20d3038c049cd6e55d2d74768556345ee5 namespace=moby
May 13 04:12:16.439177 containerd[1383]: time="2025-05-13T04:12:16.439151554Z" level=info msg="cleaning up dead shim" namespace=moby
May 13 04:12:16.456735 systemd-networkd[1299]: vethe13ae74: Lost carrier
May 13 04:12:16.458240 kernel: docker0: port 1(vethe13ae74) entered disabled state
May 13 04:12:16.458314 kernel: veth7717831: renamed from eth0
May 13 04:12:16.474342 systemd-networkd[1299]: vethe13ae74: Link DOWN
May 13 04:12:16.475012 kernel: docker0: port 1(vethe13ae74) entered disabled state
May 13 04:12:16.475049 kernel: vethe13ae74 (unregistering): left allmulticast mode
May 13 04:12:16.475068 kernel: vethe13ae74 (unregistering): left promiscuous mode
May 13 04:12:16.476738 kernel: docker0: port 1(vethe13ae74) entered disabled state
May 13 04:12:16.758753 sshd[1880]: pam_unix(sshd:session): session closed for user core
May 13 04:12:16.765702 systemd[1]: sshd@13-172.24.4.202:22-172.24.4.1:44634.service: Deactivated successfully.
May 13 04:12:16.770194 systemd[1]: session-16.scope: Deactivated successfully.
May 13 04:12:16.772293 systemd-logind[1362]: Session 16 logged out. Waiting for processes to exit.
May 13 04:12:16.774468 systemd-logind[1362]: Removed session 16.
May 13 04:12:17.146714 systemd[1]: var-lib-docker-overlay2-182488381fd5e6e98ec2e83ebb5879066bd288a3eeed1b227959a3ae9604c57a-merged.mount: Deactivated successfully.
May 13 04:12:17.352764 systemd-networkd[1299]: docker0: Lost carrier