Jun 25 18:43:01.906409 kernel: Linux version 6.6.35-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT_DYNAMIC Tue Jun 25 17:21:28 -00 2024
Jun 25 18:43:01.906432 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4483672da8ac4c95f5ee13a489103440a13110ce1f63977ab5a6a33d0c137bf8
Jun 25 18:43:01.906443 kernel: BIOS-provided physical RAM map:
Jun 25 18:43:01.906449 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
Jun 25 18:43:01.906455 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
Jun 25 18:43:01.906461 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
Jun 25 18:43:01.906468 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdcfff] usable
Jun 25 18:43:01.906475 kernel: BIOS-e820: [mem 0x000000009cfdd000-0x000000009cffffff] reserved
Jun 25 18:43:01.906481 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
Jun 25 18:43:01.906489 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
Jun 25 18:43:01.906496 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
Jun 25 18:43:01.906502 kernel: NX (Execute Disable) protection: active
Jun 25 18:43:01.906508 kernel: APIC: Static calls initialized
Jun 25 18:43:01.906514 kernel: SMBIOS 2.8 present.
Jun 25 18:43:01.906522 kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
Jun 25 18:43:01.906532 kernel: Hypervisor detected: KVM
Jun 25 18:43:01.906538 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
Jun 25 18:43:01.906545 kernel: kvm-clock: using sched offset of 2267763608 cycles
Jun 25 18:43:01.906552 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
Jun 25 18:43:01.906559 kernel: tsc: Detected 2794.750 MHz processor
Jun 25 18:43:01.906566 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Jun 25 18:43:01.906574 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Jun 25 18:43:01.906581 kernel: last_pfn = 0x9cfdd max_arch_pfn = 0x400000000
Jun 25 18:43:01.906588 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
Jun 25 18:43:01.906597 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
Jun 25 18:43:01.906604 kernel: Using GB pages for direct mapping
Jun 25 18:43:01.906611 kernel: ACPI: Early table checksum verification disabled
Jun 25 18:43:01.906618 kernel: ACPI: RSDP 0x00000000000F59C0 000014 (v00 BOCHS )
Jun 25 18:43:01.906625 kernel: ACPI: RSDT 0x000000009CFE1BDD 000034 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906632 kernel: ACPI: FACP 0x000000009CFE1A79 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906639 kernel: ACPI: DSDT 0x000000009CFE0040 001A39 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906646 kernel: ACPI: FACS 0x000000009CFE0000 000040
Jun 25 18:43:01.906653 kernel: ACPI: APIC 0x000000009CFE1AED 000090 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906662 kernel: ACPI: HPET 0x000000009CFE1B7D 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906669 kernel: ACPI: WAET 0x000000009CFE1BB5 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
Jun 25 18:43:01.906676 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe1a79-0x9cfe1aec]
Jun 25 18:43:01.906683 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe1a78]
Jun 25 18:43:01.906690 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f]
Jun 25 18:43:01.906697 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe1aed-0x9cfe1b7c]
Jun 25 18:43:01.906704 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe1b7d-0x9cfe1bb4]
Jun 25 18:43:01.906714 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe1bb5-0x9cfe1bdc]
Jun 25 18:43:01.906723 kernel: No NUMA configuration found
Jun 25 18:43:01.906731 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdcfff]
Jun 25 18:43:01.906738 kernel: NODE_DATA(0) allocated [mem 0x9cfd7000-0x9cfdcfff]
Jun 25 18:43:01.906745 kernel: Zone ranges:
Jun 25 18:43:01.906752 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Jun 25 18:43:01.906760 kernel:   DMA32    [mem 0x0000000001000000-0x000000009cfdcfff]
Jun 25 18:43:01.906769 kernel:   Normal   empty
Jun 25 18:43:01.906776 kernel: Movable zone start for each node
Jun 25 18:43:01.906783 kernel: Early memory node ranges
Jun 25 18:43:01.906790 kernel:   node   0: [mem 0x0000000000001000-0x000000000009efff]
Jun 25 18:43:01.906798 kernel:   node   0: [mem 0x0000000000100000-0x000000009cfdcfff]
Jun 25 18:43:01.906805 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdcfff]
Jun 25 18:43:01.906812 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
Jun 25 18:43:01.906819 kernel: On node 0, zone DMA: 97 pages in unavailable ranges
Jun 25 18:43:01.906826 kernel: On node 0, zone DMA32: 12323 pages in unavailable ranges
Jun 25 18:43:01.906834 kernel: ACPI: PM-Timer IO Port: 0x608
Jun 25 18:43:01.906843 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
Jun 25 18:43:01.906850 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
Jun 25 18:43:01.906857 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Jun 25 18:43:01.906865 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
Jun 25 18:43:01.906872 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Jun 25 18:43:01.906879 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
Jun 25 18:43:01.906886 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
Jun 25 18:43:01.906893 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
Jun 25 18:43:01.906901 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000
Jun 25 18:43:01.906910 kernel: TSC deadline timer available
Jun 25 18:43:01.906918 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs
Jun 25 18:43:01.906937 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
Jun 25 18:43:01.906944 kernel: kvm-guest: KVM setup pv remote TLB flush
Jun 25 18:43:01.906952 kernel: kvm-guest: setup PV sched yield
Jun 25 18:43:01.906959 kernel: [mem 0x9d000000-0xfeffbfff] available for PCI devices
Jun 25 18:43:01.906966 kernel: Booting paravirtualized kernel on KVM
Jun 25 18:43:01.906973 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
Jun 25 18:43:01.906981 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
Jun 25 18:43:01.906991 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288
Jun 25 18:43:01.906998 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152
Jun 25 18:43:01.907005 kernel: pcpu-alloc: [0] 0 1 2 3 
Jun 25 18:43:01.907012 kernel: kvm-guest: PV spinlocks enabled
Jun 25 18:43:01.907019 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
Jun 25 18:43:01.907028 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4483672da8ac4c95f5ee13a489103440a13110ce1f63977ab5a6a33d0c137bf8
Jun 25 18:43:01.907036 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Jun 25 18:43:01.907043 kernel: random: crng init done
Jun 25 18:43:01.907052 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Jun 25 18:43:01.907060 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Jun 25 18:43:01.907067 kernel: Fallback order for Node 0: 0 
Jun 25 18:43:01.907075 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 632733
Jun 25 18:43:01.907082 kernel: Policy zone: DMA32
Jun 25 18:43:01.907089 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jun 25 18:43:01.907096 kernel: Memory: 2428452K/2571756K available (12288K kernel code, 2302K rwdata, 22636K rodata, 49384K init, 1964K bss, 143044K reserved, 0K cma-reserved)
Jun 25 18:43:01.907104 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jun 25 18:43:01.907111 kernel: ftrace: allocating 37650 entries in 148 pages
Jun 25 18:43:01.907120 kernel: ftrace: allocated 148 pages with 3 groups
Jun 25 18:43:01.907128 kernel: Dynamic Preempt: voluntary
Jun 25 18:43:01.907135 kernel: rcu: Preemptible hierarchical RCU implementation.
Jun 25 18:43:01.907142 kernel: rcu:         RCU event tracing is enabled.
Jun 25 18:43:01.907150 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
Jun 25 18:43:01.907157 kernel:         Trampoline variant of Tasks RCU enabled.
Jun 25 18:43:01.907164 kernel:         Rude variant of Tasks RCU enabled.
Jun 25 18:43:01.907172 kernel:         Tracing variant of Tasks RCU enabled.
Jun 25 18:43:01.907179 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Jun 25 18:43:01.907188 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
Jun 25 18:43:01.907196 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16
Jun 25 18:43:01.907203 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Jun 25 18:43:01.907210 kernel: Console: colour VGA+ 80x25
Jun 25 18:43:01.907217 kernel: printk: console [ttyS0] enabled
Jun 25 18:43:01.907224 kernel: ACPI: Core revision 20230628
Jun 25 18:43:01.907232 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
Jun 25 18:43:01.907239 kernel: APIC: Switch to symmetric I/O mode setup
Jun 25 18:43:01.907246 kernel: x2apic enabled
Jun 25 18:43:01.907253 kernel: APIC: Switched APIC routing to: physical x2apic
Jun 25 18:43:01.907263 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()
Jun 25 18:43:01.907270 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()
Jun 25 18:43:01.907277 kernel: kvm-guest: setup PV IPIs
Jun 25 18:43:01.907285 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Jun 25 18:43:01.907292 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized
Jun 25 18:43:01.907299 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750)
Jun 25 18:43:01.907307 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated
Jun 25 18:43:01.907324 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
Jun 25 18:43:01.907331 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
Jun 25 18:43:01.907339 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
Jun 25 18:43:01.907347 kernel: Spectre V2 : Mitigation: Retpolines
Jun 25 18:43:01.907357 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
Jun 25 18:43:01.907365 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT
Jun 25 18:43:01.907372 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls
Jun 25 18:43:01.907385 kernel: RETBleed: Mitigation: untrained return thunk
Jun 25 18:43:01.907394 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
Jun 25 18:43:01.907404 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
Jun 25 18:43:01.907411 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied!
Jun 25 18:43:01.907420 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options.
Jun 25 18:43:01.907428 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode
Jun 25 18:43:01.907435 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
Jun 25 18:43:01.907443 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
Jun 25 18:43:01.907451 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
Jun 25 18:43:01.907460 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
Jun 25 18:43:01.907473 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.
Jun 25 18:43:01.907483 kernel: Freeing SMP alternatives memory: 32K
Jun 25 18:43:01.907492 kernel: pid_max: default: 32768 minimum: 301
Jun 25 18:43:01.907502 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity
Jun 25 18:43:01.907511 kernel: SELinux:  Initializing.
Jun 25 18:43:01.907521 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jun 25 18:43:01.907531 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jun 25 18:43:01.907540 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0)
Jun 25 18:43:01.907550 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
Jun 25 18:43:01.907563 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
Jun 25 18:43:01.907573 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
Jun 25 18:43:01.907582 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver.
Jun 25 18:43:01.907592 kernel: ... version:                0
Jun 25 18:43:01.907601 kernel: ... bit width:              48
Jun 25 18:43:01.907611 kernel: ... generic registers:      6
Jun 25 18:43:01.907620 kernel: ... value mask:             0000ffffffffffff
Jun 25 18:43:01.907630 kernel: ... max period:             00007fffffffffff
Jun 25 18:43:01.907639 kernel: ... fixed-purpose events:   0
Jun 25 18:43:01.907651 kernel: ... event mask:             000000000000003f
Jun 25 18:43:01.907659 kernel: signal: max sigframe size: 1776
Jun 25 18:43:01.907666 kernel: rcu: Hierarchical SRCU implementation.
Jun 25 18:43:01.907674 kernel: rcu:         Max phase no-delay instances is 400.
Jun 25 18:43:01.907682 kernel: smp: Bringing up secondary CPUs ...
Jun 25 18:43:01.907689 kernel: smpboot: x86: Booting SMP configuration:
Jun 25 18:43:01.907697 kernel: .... node  #0, CPUs:      #1 #2 #3
Jun 25 18:43:01.907704 kernel: smp: Brought up 1 node, 4 CPUs
Jun 25 18:43:01.907712 kernel: smpboot: Max logical packages: 1
Jun 25 18:43:01.907722 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS)
Jun 25 18:43:01.907730 kernel: devtmpfs: initialized
Jun 25 18:43:01.907737 kernel: x86/mm: Memory block size: 128MB
Jun 25 18:43:01.907745 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Jun 25 18:43:01.907753 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jun 25 18:43:01.907761 kernel: pinctrl core: initialized pinctrl subsystem
Jun 25 18:43:01.907768 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jun 25 18:43:01.907776 kernel: audit: initializing netlink subsys (disabled)
Jun 25 18:43:01.907784 kernel: audit: type=2000 audit(1719340981.331:1): state=initialized audit_enabled=0 res=1
Jun 25 18:43:01.907794 kernel: thermal_sys: Registered thermal governor 'step_wise'
Jun 25 18:43:01.907801 kernel: thermal_sys: Registered thermal governor 'user_space'
Jun 25 18:43:01.907809 kernel: cpuidle: using governor menu
Jun 25 18:43:01.907816 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Jun 25 18:43:01.907824 kernel: dca service started, version 1.12.1
Jun 25 18:43:01.907832 kernel: PCI: Using configuration type 1 for base access
Jun 25 18:43:01.907839 kernel: PCI: Using configuration type 1 for extended access
Jun 25 18:43:01.907847 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
Jun 25 18:43:01.907855 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
Jun 25 18:43:01.907865 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
Jun 25 18:43:01.907872 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
Jun 25 18:43:01.907880 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
Jun 25 18:43:01.907888 kernel: ACPI: Added _OSI(Module Device)
Jun 25 18:43:01.907895 kernel: ACPI: Added _OSI(Processor Device)
Jun 25 18:43:01.907903 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Jun 25 18:43:01.907911 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Jun 25 18:43:01.907918 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Jun 25 18:43:01.907958 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC
Jun 25 18:43:01.907969 kernel: ACPI: Interpreter enabled
Jun 25 18:43:01.907977 kernel: ACPI: PM: (supports S0 S3 S5)
Jun 25 18:43:01.907985 kernel: ACPI: Using IOAPIC for interrupt routing
Jun 25 18:43:01.907992 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Jun 25 18:43:01.908000 kernel: PCI: Using E820 reservations for host bridge windows
Jun 25 18:43:01.908008 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F
Jun 25 18:43:01.908016 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Jun 25 18:43:01.908194 kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
Jun 25 18:43:01.908210 kernel: acpiphp: Slot [3] registered
Jun 25 18:43:01.908218 kernel: acpiphp: Slot [4] registered
Jun 25 18:43:01.908226 kernel: acpiphp: Slot [5] registered
Jun 25 18:43:01.908233 kernel: acpiphp: Slot [6] registered
Jun 25 18:43:01.908241 kernel: acpiphp: Slot [7] registered
Jun 25 18:43:01.908248 kernel: acpiphp: Slot [8] registered
Jun 25 18:43:01.908255 kernel: acpiphp: Slot [9] registered
Jun 25 18:43:01.908263 kernel: acpiphp: Slot [10] registered
Jun 25 18:43:01.908270 kernel: acpiphp: Slot [11] registered
Jun 25 18:43:01.908278 kernel: acpiphp: Slot [12] registered
Jun 25 18:43:01.908288 kernel: acpiphp: Slot [13] registered
Jun 25 18:43:01.908295 kernel: acpiphp: Slot [14] registered
Jun 25 18:43:01.908303 kernel: acpiphp: Slot [15] registered
Jun 25 18:43:01.908310 kernel: acpiphp: Slot [16] registered
Jun 25 18:43:01.908318 kernel: acpiphp: Slot [17] registered
Jun 25 18:43:01.908325 kernel: acpiphp: Slot [18] registered
Jun 25 18:43:01.908333 kernel: acpiphp: Slot [19] registered
Jun 25 18:43:01.908340 kernel: acpiphp: Slot [20] registered
Jun 25 18:43:01.908348 kernel: acpiphp: Slot [21] registered
Jun 25 18:43:01.908360 kernel: acpiphp: Slot [22] registered
Jun 25 18:43:01.908369 kernel: acpiphp: Slot [23] registered
Jun 25 18:43:01.908388 kernel: acpiphp: Slot [24] registered
Jun 25 18:43:01.908398 kernel: acpiphp: Slot [25] registered
Jun 25 18:43:01.908407 kernel: acpiphp: Slot [26] registered
Jun 25 18:43:01.908417 kernel: acpiphp: Slot [27] registered
Jun 25 18:43:01.908426 kernel: acpiphp: Slot [28] registered
Jun 25 18:43:01.908435 kernel: acpiphp: Slot [29] registered
Jun 25 18:43:01.908445 kernel: acpiphp: Slot [30] registered
Jun 25 18:43:01.908454 kernel: acpiphp: Slot [31] registered
Jun 25 18:43:01.908466 kernel: PCI host bridge to bus 0000:00
Jun 25 18:43:01.908603 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
Jun 25 18:43:01.908715 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
Jun 25 18:43:01.908825 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
Jun 25 18:43:01.908950 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xfebfffff window]
Jun 25 18:43:01.909070 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
Jun 25 18:43:01.909180 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Jun 25 18:43:01.909322 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
Jun 25 18:43:01.909467 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
Jun 25 18:43:01.909604 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
Jun 25 18:43:01.909724 kernel: pci 0000:00:01.1: reg 0x20: [io  0xc0c0-0xc0cf]
Jun 25 18:43:01.909843 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
Jun 25 18:43:01.910000 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
Jun 25 18:43:01.910158 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
Jun 25 18:43:01.910312 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
Jun 25 18:43:01.910494 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
Jun 25 18:43:01.910759 kernel: pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
Jun 25 18:43:01.910912 kernel: pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
Jun 25 18:43:01.911081 kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
Jun 25 18:43:01.911206 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
Jun 25 18:43:01.911333 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff]
Jun 25 18:43:01.911462 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref]
Jun 25 18:43:01.911582 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
Jun 25 18:43:01.911711 kernel: pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00
Jun 25 18:43:01.911833 kernel: pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc09f]
Jun 25 18:43:01.912073 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff]
Jun 25 18:43:01.912242 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
Jun 25 18:43:01.912418 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
Jun 25 18:43:01.912544 kernel: pci 0000:00:04.0: reg 0x10: [io  0xc000-0xc07f]
Jun 25 18:43:01.912664 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff]
Jun 25 18:43:01.912785 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
Jun 25 18:43:01.912913 kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000
Jun 25 18:43:01.913068 kernel: pci 0000:00:05.0: reg 0x10: [io  0xc0a0-0xc0bf]
Jun 25 18:43:01.913196 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff]
Jun 25 18:43:01.913316 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref]
Jun 25 18:43:01.913444 kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
Jun 25 18:43:01.913455 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10
Jun 25 18:43:01.913463 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
Jun 25 18:43:01.913471 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11
Jun 25 18:43:01.913478 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
Jun 25 18:43:01.913486 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9
Jun 25 18:43:01.913494 kernel: iommu: Default domain type: Translated
Jun 25 18:43:01.913505 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
Jun 25 18:43:01.913512 kernel: PCI: Using ACPI for IRQ routing
Jun 25 18:43:01.913520 kernel: PCI: pci_cache_line_size set to 64 bytes
Jun 25 18:43:01.913527 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
Jun 25 18:43:01.913535 kernel: e820: reserve RAM buffer [mem 0x9cfdd000-0x9fffffff]
Jun 25 18:43:01.913665 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
Jun 25 18:43:01.913828 kernel: pci 0000:00:02.0: vgaarb: bridge control possible
Jun 25 18:43:01.913985 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
Jun 25 18:43:01.914006 kernel: vgaarb: loaded
Jun 25 18:43:01.914016 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
Jun 25 18:43:01.914027 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter
Jun 25 18:43:01.914037 kernel: clocksource: Switched to clocksource kvm-clock
Jun 25 18:43:01.914047 kernel: VFS: Disk quotas dquot_6.6.0
Jun 25 18:43:01.914058 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jun 25 18:43:01.914068 kernel: pnp: PnP ACPI init
Jun 25 18:43:01.914229 kernel: pnp 00:02: [dma 2]
Jun 25 18:43:01.914245 kernel: pnp: PnP ACPI: found 6 devices
Jun 25 18:43:01.914261 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Jun 25 18:43:01.914271 kernel: NET: Registered PF_INET protocol family
Jun 25 18:43:01.914282 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Jun 25 18:43:01.914292 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Jun 25 18:43:01.914303 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jun 25 18:43:01.914313 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Jun 25 18:43:01.914324 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
Jun 25 18:43:01.914334 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Jun 25 18:43:01.914348 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jun 25 18:43:01.914359 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jun 25 18:43:01.914369 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Jun 25 18:43:01.914388 kernel: NET: Registered PF_XDP protocol family
Jun 25 18:43:01.914540 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
Jun 25 18:43:01.914717 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
Jun 25 18:43:01.914874 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Jun 25 18:43:01.915129 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xfebfffff window]
Jun 25 18:43:01.915276 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
Jun 25 18:43:01.915457 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release
Jun 25 18:43:01.915612 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers
Jun 25 18:43:01.915628 kernel: PCI: CLS 0 bytes, default 64
Jun 25 18:43:01.915639 kernel: Initialise system trusted keyrings
Jun 25 18:43:01.915651 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Jun 25 18:43:01.915662 kernel: Key type asymmetric registered
Jun 25 18:43:01.915673 kernel: Asymmetric key parser 'x509' registered
Jun 25 18:43:01.915684 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
Jun 25 18:43:01.915700 kernel: io scheduler mq-deadline registered
Jun 25 18:43:01.915712 kernel: io scheduler kyber registered
Jun 25 18:43:01.915723 kernel: io scheduler bfq registered
Jun 25 18:43:01.915734 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
Jun 25 18:43:01.915745 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11
Jun 25 18:43:01.915756 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10
Jun 25 18:43:01.915767 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10
Jun 25 18:43:01.915779 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Jun 25 18:43:01.915790 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
Jun 25 18:43:01.915804 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
Jun 25 18:43:01.915816 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Jun 25 18:43:01.915827 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
Jun 25 18:43:01.916027 kernel: rtc_cmos 00:05: RTC can wake from S4
Jun 25 18:43:01.916045 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
Jun 25 18:43:01.916186 kernel: rtc_cmos 00:05: registered as rtc0
Jun 25 18:43:01.916327 kernel: rtc_cmos 00:05: setting system clock to 2024-06-25T18:43:01 UTC (1719340981)
Jun 25 18:43:01.916481 kernel: rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
Jun 25 18:43:01.916504 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
Jun 25 18:43:01.916518 kernel: NET: Registered PF_INET6 protocol family
Jun 25 18:43:01.916530 kernel: Segment Routing with IPv6
Jun 25 18:43:01.916544 kernel: In-situ OAM (IOAM) with IPv6
Jun 25 18:43:01.916555 kernel: NET: Registered PF_PACKET protocol family
Jun 25 18:43:01.916566 kernel: Key type dns_resolver registered
Jun 25 18:43:01.916577 kernel: IPI shorthand broadcast: enabled
Jun 25 18:43:01.916588 kernel: sched_clock: Marking stable (687004077, 103176561)->(842924583, -52743945)
Jun 25 18:43:01.916599 kernel: registered taskstats version 1
Jun 25 18:43:01.916613 kernel: Loading compiled-in X.509 certificates
Jun 25 18:43:01.916625 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.35-flatcar: 60204e9db5f484c670a1c92aec37e9a0c4d3ae90'
Jun 25 18:43:01.916636 kernel: Key type .fscrypt registered
Jun 25 18:43:01.916648 kernel: Key type fscrypt-provisioning registered
Jun 25 18:43:01.916659 kernel: ima: No TPM chip found, activating TPM-bypass!
Jun 25 18:43:01.916670 kernel: ima: Allocated hash algorithm: sha1
Jun 25 18:43:01.916682 kernel: ima: No architecture policies found
Jun 25 18:43:01.916693 kernel: clk: Disabling unused clocks
Jun 25 18:43:01.916705 kernel: Freeing unused kernel image (initmem) memory: 49384K
Jun 25 18:43:01.916720 kernel: Write protecting the kernel read-only data: 36864k
Jun 25 18:43:01.916731 kernel: Freeing unused kernel image (rodata/data gap) memory: 1940K
Jun 25 18:43:01.916743 kernel: Run /init as init process
Jun 25 18:43:01.916754 kernel:   with arguments:
Jun 25 18:43:01.916765 kernel:     /init
Jun 25 18:43:01.916776 kernel:   with environment:
Jun 25 18:43:01.916787 kernel:     HOME=/
Jun 25 18:43:01.916820 kernel:     TERM=linux
Jun 25 18:43:01.916834 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
Jun 25 18:43:01.916851 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)
Jun 25 18:43:01.916865 systemd[1]: Detected virtualization kvm.
Jun 25 18:43:01.916878 systemd[1]: Detected architecture x86-64.
Jun 25 18:43:01.916890 systemd[1]: Running in initrd.
Jun 25 18:43:01.916902 systemd[1]: No hostname configured, using default hostname.
Jun 25 18:43:01.916914 systemd[1]: Hostname set to <localhost>.
Jun 25 18:43:01.916943 systemd[1]: Initializing machine ID from VM UUID.
Jun 25 18:43:01.916956 systemd[1]: Queued start job for default target initrd.target.
Jun 25 18:43:01.916969 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jun 25 18:43:01.916981 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jun 25 18:43:01.916994 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
Jun 25 18:43:01.917007 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Jun 25 18:43:01.917020 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
Jun 25 18:43:01.917032 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
Jun 25 18:43:01.917051 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
Jun 25 18:43:01.917064 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
Jun 25 18:43:01.917076 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jun 25 18:43:01.917089 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Jun 25 18:43:01.917101 systemd[1]: Reached target paths.target - Path Units.
Jun 25 18:43:01.917114 systemd[1]: Reached target slices.target - Slice Units.
Jun 25 18:43:01.917126 systemd[1]: Reached target swap.target - Swaps.
Jun 25 18:43:01.917139 systemd[1]: Reached target timers.target - Timer Units.
Jun 25 18:43:01.917154 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
Jun 25 18:43:01.917166 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Jun 25 18:43:01.917179 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
Jun 25 18:43:01.917191 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
Jun 25 18:43:01.917204 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Jun 25 18:43:01.917216 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Jun 25 18:43:01.917229 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Jun 25 18:43:01.917242 systemd[1]: Reached target sockets.target - Socket Units.
Jun 25 18:43:01.917257 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
Jun 25 18:43:01.917270 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Jun 25 18:43:01.917282 systemd[1]: Finished network-cleanup.service - Network Cleanup.
Jun 25 18:43:01.917295 systemd[1]: Starting systemd-fsck-usr.service...
Jun 25 18:43:01.917308 systemd[1]: Starting systemd-journald.service - Journal Service...
Jun 25 18:43:01.917320 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Jun 25 18:43:01.917336 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jun 25 18:43:01.917349 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
Jun 25 18:43:01.917362 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Jun 25 18:43:01.917374 systemd[1]: Finished systemd-fsck-usr.service.
Jun 25 18:43:01.917417 systemd-journald[192]: Collecting audit messages is disabled.
Jun 25 18:43:01.917450 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Jun 25 18:43:01.917463 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jun 25 18:43:01.917476 systemd-journald[192]: Journal started
Jun 25 18:43:01.917505 systemd-journald[192]: Runtime Journal (/run/log/journal/6f50f9ae1ffb46618c48d0fd3ecf5079) is 6.0M, max 48.4M, 42.3M free.
Jun 25 18:43:01.912425 systemd-modules-load[193]: Inserted module 'overlay'
Jun 25 18:43:01.950055 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Jun 25 18:43:01.950075 kernel: Bridge firewalling registered
Jun 25 18:43:01.944639 systemd-modules-load[193]: Inserted module 'br_netfilter'
Jun 25 18:43:01.951748 systemd[1]: Started systemd-journald.service - Journal Service.
Jun 25 18:43:01.953034 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Jun 25 18:43:01.955331 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jun 25 18:43:01.969083 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jun 25 18:43:01.972278 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Jun 25 18:43:01.974884 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Jun 25 18:43:01.978043 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories...
Jun 25 18:43:01.988085 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jun 25 18:43:01.989263 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Jun 25 18:43:01.993757 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories.
Jun 25 18:43:02.004105 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Jun 25 18:43:02.004783 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jun 25 18:43:02.007474 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
Jun 25 18:43:02.022685 dracut-cmdline[233]: dracut-dracut-053
Jun 25 18:43:02.025502 dracut-cmdline[233]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4483672da8ac4c95f5ee13a489103440a13110ce1f63977ab5a6a33d0c137bf8
Jun 25 18:43:02.036628 systemd-resolved[230]: Positive Trust Anchors:
Jun 25 18:43:02.036645 systemd-resolved[230]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jun 25 18:43:02.036675 systemd-resolved[230]: 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 corp home internal intranet lan local private test
Jun 25 18:43:02.039296 systemd-resolved[230]: Defaulting to hostname 'linux'.
Jun 25 18:43:02.040358 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Jun 25 18:43:02.046218 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Jun 25 18:43:02.109978 kernel: SCSI subsystem initialized
Jun 25 18:43:02.120958 kernel: Loading iSCSI transport class v2.0-870.
Jun 25 18:43:02.133967 kernel: iscsi: registered transport (tcp)
Jun 25 18:43:02.158984 kernel: iscsi: registered transport (qla4xxx)
Jun 25 18:43:02.159056 kernel: QLogic iSCSI HBA Driver
Jun 25 18:43:02.210556 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
Jun 25 18:43:02.220052 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
Jun 25 18:43:02.252950 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Jun 25 18:43:02.253023 kernel: device-mapper: uevent: version 1.0.3
Jun 25 18:43:02.253036 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
Jun 25 18:43:02.301988 kernel: raid6: avx2x4   gen() 25683 MB/s
Jun 25 18:43:02.318954 kernel: raid6: avx2x2   gen() 24795 MB/s
Jun 25 18:43:02.336133 kernel: raid6: avx2x1   gen() 20878 MB/s
Jun 25 18:43:02.336170 kernel: raid6: using algorithm avx2x4 gen() 25683 MB/s
Jun 25 18:43:02.354063 kernel: raid6: .... xor() 8350 MB/s, rmw enabled
Jun 25 18:43:02.354143 kernel: raid6: using avx2x2 recovery algorithm
Jun 25 18:43:02.378976 kernel: xor: automatically using best checksumming function   avx       
Jun 25 18:43:02.576977 kernel: Btrfs loaded, zoned=no, fsverity=no
Jun 25 18:43:02.591882 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
Jun 25 18:43:02.599203 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jun 25 18:43:02.612644 systemd-udevd[415]: Using default interface naming scheme 'v255'.
Jun 25 18:43:02.618277 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jun 25 18:43:02.626110 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
Jun 25 18:43:02.642394 dracut-pre-trigger[422]: rd.md=0: removing MD RAID activation
Jun 25 18:43:02.681608 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
Jun 25 18:43:02.694182 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Jun 25 18:43:02.762052 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Jun 25 18:43:02.772176 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
Jun 25 18:43:02.785972 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
Jun 25 18:43:02.789590 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
Jun 25 18:43:02.792739 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Jun 25 18:43:02.795285 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Jun 25 18:43:02.800054 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues
Jun 25 18:43:02.813024 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB)
Jun 25 18:43:02.813175 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jun 25 18:43:02.813196 kernel: cryptd: max_cpu_qlen set to 1000
Jun 25 18:43:02.807419 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
Jun 25 18:43:02.820749 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
Jun 25 18:43:02.828950 kernel: libata version 3.00 loaded.
Jun 25 18:43:02.828982 kernel: AVX2 version of gcm_enc/dec engaged.
Jun 25 18:43:02.830956 kernel: AES CTR mode by8 optimization enabled
Jun 25 18:43:02.834546 kernel: ata_piix 0000:00:01.1: version 2.13
Jun 25 18:43:02.840888 kernel: scsi host0: ata_piix
Jun 25 18:43:02.841078 kernel: scsi host1: ata_piix
Jun 25 18:43:02.841249 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14
Jun 25 18:43:02.841265 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15
Jun 25 18:43:02.849962 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (463)
Jun 25 18:43:02.855671 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
Jun 25 18:43:02.859460 kernel: BTRFS: device fsid 329ce27e-ea89-47b5-8f8b-f762c8412eb0 devid 1 transid 31 /dev/vda3 scanned by (udev-worker) (470)
Jun 25 18:43:02.871408 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
Jun 25 18:43:02.877505 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
Jun 25 18:43:02.882879 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
Jun 25 18:43:02.884187 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
Jun 25 18:43:02.902075 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
Jun 25 18:43:02.913034 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jun 25 18:43:02.903486 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Jun 25 18:43:02.903541 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jun 25 18:43:02.904229 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jun 25 18:43:02.918851 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jun 25 18:43:02.904435 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Jun 25 18:43:02.904485 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Jun 25 18:43:02.904867 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
Jun 25 18:43:02.905888 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jun 25 18:43:02.967251 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jun 25 18:43:02.992974 kernel: ata2: found unknown device (class 0)
Jun 25 18:43:02.993979 kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
Jun 25 18:43:02.996950 kernel: scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
Jun 25 18:43:03.014062 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jun 25 18:43:03.033500 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jun 25 18:43:03.055960 kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
Jun 25 18:43:03.072822 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Jun 25 18:43:03.072838 kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0
Jun 25 18:43:03.922959 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jun 25 18:43:03.923600 disk-uuid[541]: The operation has completed successfully.
Jun 25 18:43:03.952743 systemd[1]: disk-uuid.service: Deactivated successfully.
Jun 25 18:43:03.953842 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
Jun 25 18:43:03.986269 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
Jun 25 18:43:03.989605 sh[580]: Success
Jun 25 18:43:04.003961 kernel: device-mapper: verity: sha256 using implementation "sha256-ni"
Jun 25 18:43:04.036977 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
Jun 25 18:43:04.060686 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
Jun 25 18:43:04.064199 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
Jun 25 18:43:04.076285 kernel: BTRFS info (device dm-0): first mount of filesystem 329ce27e-ea89-47b5-8f8b-f762c8412eb0
Jun 25 18:43:04.076320 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
Jun 25 18:43:04.076344 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
Jun 25 18:43:04.077367 kernel: BTRFS info (device dm-0): disabling log replay at mount time
Jun 25 18:43:04.078138 kernel: BTRFS info (device dm-0): using free space tree
Jun 25 18:43:04.083304 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
Jun 25 18:43:04.086277 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
Jun 25 18:43:04.100178 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
Jun 25 18:43:04.102309 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
Jun 25 18:43:04.112103 kernel: BTRFS info (device vda6): first mount of filesystem e6704e83-f8c1-4f1f-ad66-682b94c5899a
Jun 25 18:43:04.112131 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
Jun 25 18:43:04.112143 kernel: BTRFS info (device vda6): using free space tree
Jun 25 18:43:04.115960 kernel: BTRFS info (device vda6): auto enabling async discard
Jun 25 18:43:04.126442 systemd[1]: mnt-oem.mount: Deactivated successfully.
Jun 25 18:43:04.128976 kernel: BTRFS info (device vda6): last unmount of filesystem e6704e83-f8c1-4f1f-ad66-682b94c5899a
Jun 25 18:43:04.140400 systemd[1]: Finished ignition-setup.service - Ignition (setup).
Jun 25 18:43:04.146135 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
Jun 25 18:43:04.210236 ignition[670]: Ignition 2.19.0
Jun 25 18:43:04.210251 ignition[670]: Stage: fetch-offline
Jun 25 18:43:04.210294 ignition[670]: no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:04.210306 ignition[670]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:04.210445 ignition[670]: parsed url from cmdline: ""
Jun 25 18:43:04.210451 ignition[670]: no config URL provided
Jun 25 18:43:04.210459 ignition[670]: reading system config file "/usr/lib/ignition/user.ign"
Jun 25 18:43:04.210471 ignition[670]: no config at "/usr/lib/ignition/user.ign"
Jun 25 18:43:04.210502 ignition[670]: op(1): [started]  loading QEMU firmware config module
Jun 25 18:43:04.210508 ignition[670]: op(1): executing: "modprobe" "qemu_fw_cfg"
Jun 25 18:43:04.218268 ignition[670]: op(1): [finished] loading QEMU firmware config module
Jun 25 18:43:04.219765 ignition[670]: parsing config with SHA512: a1aa42545141b69c7147aaff5062fae7c5f1693a6626b4e71a14c271c95351368915b694c94fdac5129daa4d4df52ebe68d940d6f316fc9db15cf5f8079bd3cc
Jun 25 18:43:04.226123 unknown[670]: fetched base config from "system"
Jun 25 18:43:04.226140 unknown[670]: fetched user config from "qemu"
Jun 25 18:43:04.226350 ignition[670]: fetch-offline: fetch-offline passed
Jun 25 18:43:04.226434 ignition[670]: Ignition finished successfully
Jun 25 18:43:04.228783 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
Jun 25 18:43:04.239366 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Jun 25 18:43:04.253203 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Jun 25 18:43:04.275458 systemd-networkd[772]: lo: Link UP
Jun 25 18:43:04.275471 systemd-networkd[772]: lo: Gained carrier
Jun 25 18:43:04.277283 systemd-networkd[772]: Enumeration completed
Jun 25 18:43:04.277681 systemd-networkd[772]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jun 25 18:43:04.277685 systemd-networkd[772]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jun 25 18:43:04.278524 systemd[1]: Started systemd-networkd.service - Network Configuration.
Jun 25 18:43:04.278693 systemd-networkd[772]: eth0: Link UP
Jun 25 18:43:04.278697 systemd-networkd[772]: eth0: Gained carrier
Jun 25 18:43:04.278703 systemd-networkd[772]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jun 25 18:43:04.285251 systemd[1]: Reached target network.target - Network.
Jun 25 18:43:04.289536 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json).
Jun 25 18:43:04.292988 systemd-networkd[772]: eth0: DHCPv4 address 10.0.0.127/16, gateway 10.0.0.1 acquired from 10.0.0.1
Jun 25 18:43:04.300079 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
Jun 25 18:43:04.314545 ignition[775]: Ignition 2.19.0
Jun 25 18:43:04.314556 ignition[775]: Stage: kargs
Jun 25 18:43:04.314750 ignition[775]: no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:04.314762 ignition[775]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:04.318232 ignition[775]: kargs: kargs passed
Jun 25 18:43:04.318275 ignition[775]: Ignition finished successfully
Jun 25 18:43:04.322809 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
Jun 25 18:43:04.335120 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
Jun 25 18:43:04.349608 ignition[785]: Ignition 2.19.0
Jun 25 18:43:04.349619 ignition[785]: Stage: disks
Jun 25 18:43:04.349829 ignition[785]: no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:04.349840 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:04.352969 systemd[1]: Finished ignition-disks.service - Ignition (disks).
Jun 25 18:43:04.350474 ignition[785]: disks: disks passed
Jun 25 18:43:04.354582 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
Jun 25 18:43:04.350524 ignition[785]: Ignition finished successfully
Jun 25 18:43:04.356452 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
Jun 25 18:43:04.358386 systemd[1]: Reached target local-fs.target - Local File Systems.
Jun 25 18:43:04.360701 systemd[1]: Reached target sysinit.target - System Initialization.
Jun 25 18:43:04.361766 systemd[1]: Reached target basic.target - Basic System.
Jun 25 18:43:04.372170 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
Jun 25 18:43:04.384784 systemd-fsck[797]: ROOT: clean, 14/553520 files, 52654/553472 blocks
Jun 25 18:43:04.391013 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
Jun 25 18:43:04.404055 systemd[1]: Mounting sysroot.mount - /sysroot...
Jun 25 18:43:04.507960 kernel: EXT4-fs (vda9): mounted filesystem ed685e11-963b-427a-9b96-a4691c40e909 r/w with ordered data mode. Quota mode: none.
Jun 25 18:43:04.508186 systemd[1]: Mounted sysroot.mount - /sysroot.
Jun 25 18:43:04.509743 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
Jun 25 18:43:04.521047 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Jun 25 18:43:04.523696 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
Jun 25 18:43:04.524674 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
Jun 25 18:43:04.524717 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Jun 25 18:43:04.532493 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (805)
Jun 25 18:43:04.524741 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
Jun 25 18:43:04.536229 kernel: BTRFS info (device vda6): first mount of filesystem e6704e83-f8c1-4f1f-ad66-682b94c5899a
Jun 25 18:43:04.536247 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
Jun 25 18:43:04.536262 kernel: BTRFS info (device vda6): using free space tree
Jun 25 18:43:04.538951 kernel: BTRFS info (device vda6): auto enabling async discard
Jun 25 18:43:04.540533 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Jun 25 18:43:04.552468 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
Jun 25 18:43:04.554380 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
Jun 25 18:43:04.595598 initrd-setup-root[829]: cut: /sysroot/etc/passwd: No such file or directory
Jun 25 18:43:04.600048 initrd-setup-root[836]: cut: /sysroot/etc/group: No such file or directory
Jun 25 18:43:04.604152 initrd-setup-root[843]: cut: /sysroot/etc/shadow: No such file or directory
Jun 25 18:43:04.608107 initrd-setup-root[850]: cut: /sysroot/etc/gshadow: No such file or directory
Jun 25 18:43:04.695637 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
Jun 25 18:43:04.703162 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
Jun 25 18:43:04.706410 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
Jun 25 18:43:04.711956 kernel: BTRFS info (device vda6): last unmount of filesystem e6704e83-f8c1-4f1f-ad66-682b94c5899a
Jun 25 18:43:04.733500 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
Jun 25 18:43:04.736522 ignition[918]: INFO     : Ignition 2.19.0
Jun 25 18:43:04.736522 ignition[918]: INFO     : Stage: mount
Jun 25 18:43:04.738260 ignition[918]: INFO     : no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:04.738260 ignition[918]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:04.741342 ignition[918]: INFO     : mount: mount passed
Jun 25 18:43:04.742164 ignition[918]: INFO     : Ignition finished successfully
Jun 25 18:43:04.745843 systemd[1]: Finished ignition-mount.service - Ignition (mount).
Jun 25 18:43:04.758180 systemd[1]: Starting ignition-files.service - Ignition (files)...
Jun 25 18:43:05.075336 systemd[1]: sysroot-oem.mount: Deactivated successfully.
Jun 25 18:43:05.089103 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Jun 25 18:43:05.096403 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (933)
Jun 25 18:43:05.096433 kernel: BTRFS info (device vda6): first mount of filesystem e6704e83-f8c1-4f1f-ad66-682b94c5899a
Jun 25 18:43:05.096444 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
Jun 25 18:43:05.097262 kernel: BTRFS info (device vda6): using free space tree
Jun 25 18:43:05.099948 kernel: BTRFS info (device vda6): auto enabling async discard
Jun 25 18:43:05.101390 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Jun 25 18:43:05.126797 ignition[951]: INFO     : Ignition 2.19.0
Jun 25 18:43:05.126797 ignition[951]: INFO     : Stage: files
Jun 25 18:43:05.128762 ignition[951]: INFO     : no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:05.128762 ignition[951]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:05.128762 ignition[951]: DEBUG    : files: compiled without relabeling support, skipping
Jun 25 18:43:05.128762 ignition[951]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
Jun 25 18:43:05.128762 ignition[951]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(4): [started]  processing unit "etcd-member.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(4): op(5): [started]  writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(4): [finished] processing unit "etcd-member.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(6): [started]  processing unit "coreos-metadata.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(6): op(7): [started]  writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(6): [finished] processing unit "coreos-metadata.service"
Jun 25 18:43:05.135690 ignition[951]: INFO     : files: op(8): [started]  setting preset to disabled for "coreos-metadata.service"
Jun 25 18:43:05.131526 unknown[951]: wrote ssh authorized keys file for user: core
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: op(8): op(9): [started]  removing enablement symlink(s) for "coreos-metadata.service"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: op(a): [started]  setting preset to enabled for "etcd-member.service"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: op(a): [finished] setting preset to enabled for "etcd-member.service"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: createResultFile: createFiles: op(b): [started]  writing file "/sysroot/etc/.ignition-result.json"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json"
Jun 25 18:43:05.167052 ignition[951]: INFO     : files: files passed
Jun 25 18:43:05.167052 ignition[951]: INFO     : Ignition finished successfully
Jun 25 18:43:05.165086 systemd[1]: Finished ignition-files.service - Ignition (files).
Jun 25 18:43:05.186266 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
Jun 25 18:43:05.188437 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
Jun 25 18:43:05.190781 systemd[1]: ignition-quench.service: Deactivated successfully.
Jun 25 18:43:05.190898 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
Jun 25 18:43:05.199013 initrd-setup-root-after-ignition[979]: grep: /sysroot/oem/oem-release: No such file or directory
Jun 25 18:43:05.201703 initrd-setup-root-after-ignition[981]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Jun 25 18:43:05.203744 initrd-setup-root-after-ignition[981]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
Jun 25 18:43:05.205638 initrd-setup-root-after-ignition[985]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Jun 25 18:43:05.205729 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
Jun 25 18:43:05.209129 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
Jun 25 18:43:05.222115 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
Jun 25 18:43:05.252843 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Jun 25 18:43:05.253015 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
Jun 25 18:43:05.255544 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
Jun 25 18:43:05.257861 systemd[1]: Reached target initrd.target - Initrd Default Target.
Jun 25 18:43:05.260190 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
Jun 25 18:43:05.261190 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
Jun 25 18:43:05.281233 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Jun 25 18:43:05.298264 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
Jun 25 18:43:05.311791 systemd[1]: Stopped target network.target - Network.
Jun 25 18:43:05.312455 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
Jun 25 18:43:05.314367 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
Jun 25 18:43:05.314738 systemd[1]: Stopped target timers.target - Timer Units.
Jun 25 18:43:05.319445 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Jun 25 18:43:05.319609 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Jun 25 18:43:05.323006 systemd[1]: Stopped target initrd.target - Initrd Default Target.
Jun 25 18:43:05.323586 systemd[1]: Stopped target basic.target - Basic System.
Jun 25 18:43:05.323984 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
Jun 25 18:43:05.328547 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
Jun 25 18:43:05.328891 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
Jun 25 18:43:05.333489 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
Jun 25 18:43:05.335591 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
Jun 25 18:43:05.335986 systemd[1]: Stopped target sysinit.target - System Initialization.
Jun 25 18:43:05.340425 systemd[1]: Stopped target local-fs.target - Local File Systems.
Jun 25 18:43:05.340751 systemd[1]: Stopped target swap.target - Swaps.
Jun 25 18:43:05.344714 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Jun 25 18:43:05.344877 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
Jun 25 18:43:05.346922 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
Jun 25 18:43:05.347341 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jun 25 18:43:05.347653 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
Jun 25 18:43:05.347840 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jun 25 18:43:05.354319 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Jun 25 18:43:05.354457 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
Jun 25 18:43:05.358848 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Jun 25 18:43:05.359021 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
Jun 25 18:43:05.359600 systemd[1]: Stopped target paths.target - Path Units.
Jun 25 18:43:05.362793 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Jun 25 18:43:05.368010 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jun 25 18:43:05.371282 systemd[1]: Stopped target slices.target - Slice Units.
Jun 25 18:43:05.373468 systemd[1]: Stopped target sockets.target - Socket Units.
Jun 25 18:43:05.375777 systemd[1]: iscsid.socket: Deactivated successfully.
Jun 25 18:43:05.376974 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
Jun 25 18:43:05.379315 systemd[1]: iscsiuio.socket: Deactivated successfully.
Jun 25 18:43:05.379409 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Jun 25 18:43:05.382411 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Jun 25 18:43:05.383632 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
Jun 25 18:43:05.386228 systemd[1]: ignition-files.service: Deactivated successfully.
Jun 25 18:43:05.387247 systemd[1]: Stopped ignition-files.service - Ignition (files).
Jun 25 18:43:05.400244 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
Jun 25 18:43:05.403613 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
Jun 25 18:43:05.406066 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
Jun 25 18:43:05.408737 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
Jun 25 18:43:05.411135 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Jun 25 18:43:05.412495 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
Jun 25 18:43:05.412994 systemd-networkd[772]: eth0: DHCPv6 lease lost
Jun 25 18:43:05.415347 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Jun 25 18:43:05.415517 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
Jun 25 18:43:05.421208 ignition[1005]: INFO     : Ignition 2.19.0
Jun 25 18:43:05.421208 ignition[1005]: INFO     : Stage: umount
Jun 25 18:43:05.421208 ignition[1005]: INFO     : no configs at "/usr/lib/ignition/base.d"
Jun 25 18:43:05.421208 ignition[1005]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jun 25 18:43:05.421208 ignition[1005]: INFO     : umount: umount passed
Jun 25 18:43:05.421208 ignition[1005]: INFO     : Ignition finished successfully
Jun 25 18:43:05.421465 systemd[1]: systemd-resolved.service: Deactivated successfully.
Jun 25 18:43:05.421642 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
Jun 25 18:43:05.426362 systemd[1]: systemd-networkd.service: Deactivated successfully.
Jun 25 18:43:05.426544 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
Jun 25 18:43:05.429070 systemd[1]: ignition-mount.service: Deactivated successfully.
Jun 25 18:43:05.429194 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
Jun 25 18:43:05.433505 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Jun 25 18:43:05.436963 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Jun 25 18:43:05.437090 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
Jun 25 18:43:05.439122 systemd[1]: sysroot-boot.service: Deactivated successfully.
Jun 25 18:43:05.439231 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
Jun 25 18:43:05.442316 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Jun 25 18:43:05.442393 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
Jun 25 18:43:05.444151 systemd[1]: ignition-disks.service: Deactivated successfully.
Jun 25 18:43:05.444213 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
Jun 25 18:43:05.446096 systemd[1]: ignition-kargs.service: Deactivated successfully.
Jun 25 18:43:05.446147 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
Jun 25 18:43:05.448003 systemd[1]: ignition-setup.service: Deactivated successfully.
Jun 25 18:43:05.448058 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
Jun 25 18:43:05.449872 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
Jun 25 18:43:05.449921 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
Jun 25 18:43:05.452005 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Jun 25 18:43:05.452059 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
Jun 25 18:43:05.462080 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
Jun 25 18:43:05.463877 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Jun 25 18:43:05.463974 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Jun 25 18:43:05.466180 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Jun 25 18:43:05.466234 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
Jun 25 18:43:05.468443 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Jun 25 18:43:05.468496 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
Jun 25 18:43:05.469679 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
Jun 25 18:43:05.469729 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories.
Jun 25 18:43:05.472334 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jun 25 18:43:05.484597 systemd[1]: network-cleanup.service: Deactivated successfully.
Jun 25 18:43:05.484765 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
Jun 25 18:43:05.492021 systemd[1]: systemd-udevd.service: Deactivated successfully.
Jun 25 18:43:05.492269 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jun 25 18:43:05.495222 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Jun 25 18:43:05.495306 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
Jun 25 18:43:05.497687 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Jun 25 18:43:05.497742 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
Jun 25 18:43:05.500209 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Jun 25 18:43:05.500277 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
Jun 25 18:43:05.503061 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Jun 25 18:43:05.503122 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
Jun 25 18:43:05.505183 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Jun 25 18:43:05.505255 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jun 25 18:43:05.516098 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
Jun 25 18:43:05.517488 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Jun 25 18:43:05.517553 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jun 25 18:43:05.520235 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
Jun 25 18:43:05.520288 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jun 25 18:43:05.523108 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Jun 25 18:43:05.523158 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
Jun 25 18:43:05.526146 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Jun 25 18:43:05.526196 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Jun 25 18:43:05.529260 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Jun 25 18:43:05.529407 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
Jun 25 18:43:05.532715 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
Jun 25 18:43:05.548089 systemd[1]: Starting initrd-switch-root.service - Switch Root...
Jun 25 18:43:05.557504 systemd[1]: Switching root.
Jun 25 18:43:05.590689 systemd-journald[192]: Journal stopped
Jun 25 18:43:06.505845 systemd-journald[192]: Received SIGTERM from PID 1 (systemd).
Jun 25 18:43:06.507190 kernel: SELinux:  policy capability network_peer_controls=1
Jun 25 18:43:06.507214 kernel: SELinux:  policy capability open_perms=1
Jun 25 18:43:06.507227 kernel: SELinux:  policy capability extended_socket_class=1
Jun 25 18:43:06.507248 kernel: SELinux:  policy capability always_check_network=0
Jun 25 18:43:06.507260 kernel: SELinux:  policy capability cgroup_seclabel=1
Jun 25 18:43:06.507282 kernel: SELinux:  policy capability nnp_nosuid_transition=1
Jun 25 18:43:06.507296 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
Jun 25 18:43:06.507307 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
Jun 25 18:43:06.507319 kernel: audit: type=1403 audit(1719340985.680:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
Jun 25 18:43:06.507336 systemd[1]: Successfully loaded SELinux policy in 46.824ms.
Jun 25 18:43:06.507356 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.312ms.
Jun 25 18:43:06.507372 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)
Jun 25 18:43:06.507384 systemd[1]: Detected virtualization kvm.
Jun 25 18:43:06.507396 systemd[1]: Detected architecture x86-64.
Jun 25 18:43:06.507408 systemd[1]: Detected first boot.
Jun 25 18:43:06.507419 systemd[1]: Initializing machine ID from VM UUID.
Jun 25 18:43:06.507431 zram_generator::config[1049]: No configuration found.
Jun 25 18:43:06.507445 systemd[1]: Populated /etc with preset unit settings.
Jun 25 18:43:06.507462 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Jun 25 18:43:06.507474 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
Jun 25 18:43:06.507488 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Jun 25 18:43:06.507503 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
Jun 25 18:43:06.507515 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
Jun 25 18:43:06.507527 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
Jun 25 18:43:06.507542 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
Jun 25 18:43:06.507557 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
Jun 25 18:43:06.507569 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
Jun 25 18:43:06.507582 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
Jun 25 18:43:06.507594 systemd[1]: Created slice user.slice - User and Session Slice.
Jun 25 18:43:06.507607 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jun 25 18:43:06.507620 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jun 25 18:43:06.507632 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
Jun 25 18:43:06.507644 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
Jun 25 18:43:06.507656 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
Jun 25 18:43:06.507670 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Jun 25 18:43:06.507683 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
Jun 25 18:43:06.507695 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jun 25 18:43:06.507707 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
Jun 25 18:43:06.507719 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
Jun 25 18:43:06.507731 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
Jun 25 18:43:06.507743 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
Jun 25 18:43:06.507758 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Jun 25 18:43:06.507771 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Jun 25 18:43:06.507784 systemd[1]: Reached target slices.target - Slice Units.
Jun 25 18:43:06.507796 systemd[1]: Reached target swap.target - Swaps.
Jun 25 18:43:06.507808 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
Jun 25 18:43:06.507820 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
Jun 25 18:43:06.507832 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Jun 25 18:43:06.507851 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Jun 25 18:43:06.507862 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Jun 25 18:43:06.507875 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
Jun 25 18:43:06.507889 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
Jun 25 18:43:06.507901 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
Jun 25 18:43:06.507913 systemd[1]: Mounting media.mount - External Media Directory...
Jun 25 18:43:06.507925 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:06.507951 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
Jun 25 18:43:06.507963 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
Jun 25 18:43:06.507976 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
Jun 25 18:43:06.507993 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).
Jun 25 18:43:06.508013 systemd[1]: Reached target machines.target - Containers.
Jun 25 18:43:06.508025 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
Jun 25 18:43:06.508038 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jun 25 18:43:06.508050 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Jun 25 18:43:06.508063 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
Jun 25 18:43:06.508076 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jun 25 18:43:06.508088 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Jun 25 18:43:06.508102 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jun 25 18:43:06.508114 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
Jun 25 18:43:06.508129 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jun 25 18:43:06.508141 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Jun 25 18:43:06.508153 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Jun 25 18:43:06.508165 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
Jun 25 18:43:06.508177 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Jun 25 18:43:06.508189 systemd[1]: Stopped systemd-fsck-usr.service.
Jun 25 18:43:06.508201 systemd[1]: Starting systemd-journald.service - Journal Service...
Jun 25 18:43:06.508213 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Jun 25 18:43:06.508224 kernel: fuse: init (API version 7.39)
Jun 25 18:43:06.508239 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
Jun 25 18:43:06.508251 kernel: loop: module loaded
Jun 25 18:43:06.508262 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
Jun 25 18:43:06.508284 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Jun 25 18:43:06.508296 systemd[1]: verity-setup.service: Deactivated successfully.
Jun 25 18:43:06.508308 systemd[1]: Stopped verity-setup.service.
Jun 25 18:43:06.508320 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:06.508353 systemd-journald[1118]: Collecting audit messages is disabled.
Jun 25 18:43:06.508385 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
Jun 25 18:43:06.508397 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
Jun 25 18:43:06.508409 systemd[1]: Mounted media.mount - External Media Directory.
Jun 25 18:43:06.508422 systemd-journald[1118]: Journal started
Jun 25 18:43:06.508446 systemd-journald[1118]: Runtime Journal (/run/log/journal/6f50f9ae1ffb46618c48d0fd3ecf5079) is 6.0M, max 48.4M, 42.3M free.
Jun 25 18:43:06.276649 systemd[1]: Queued start job for default target multi-user.target.
Jun 25 18:43:06.297973 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
Jun 25 18:43:06.298443 systemd[1]: systemd-journald.service: Deactivated successfully.
Jun 25 18:43:06.511980 systemd[1]: Started systemd-journald.service - Journal Service.
Jun 25 18:43:06.512956 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
Jun 25 18:43:06.514321 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
Jun 25 18:43:06.515557 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
Jun 25 18:43:06.516805 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Jun 25 18:43:06.518379 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Jun 25 18:43:06.518552 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
Jun 25 18:43:06.520090 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
Jun 25 18:43:06.521568 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jun 25 18:43:06.521738 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jun 25 18:43:06.523196 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jun 25 18:43:06.523373 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jun 25 18:43:06.524901 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Jun 25 18:43:06.525081 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
Jun 25 18:43:06.526478 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jun 25 18:43:06.526644 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jun 25 18:43:06.528261 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Jun 25 18:43:06.530227 kernel: ACPI: bus type drm_connector registered
Jun 25 18:43:06.530418 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
Jun 25 18:43:06.532515 systemd[1]: modprobe@drm.service: Deactivated successfully.
Jun 25 18:43:06.532681 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Jun 25 18:43:06.534202 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
Jun 25 18:43:06.548752 systemd[1]: Reached target network-pre.target - Preparation for Network.
Jun 25 18:43:06.558107 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
Jun 25 18:43:06.560587 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
Jun 25 18:43:06.561740 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Jun 25 18:43:06.561765 systemd[1]: Reached target local-fs.target - Local File Systems.
Jun 25 18:43:06.563785 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink).
Jun 25 18:43:06.566169 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
Jun 25 18:43:06.571122 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
Jun 25 18:43:06.572543 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jun 25 18:43:06.574635 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
Jun 25 18:43:06.577469 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
Jun 25 18:43:06.580614 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Jun 25 18:43:06.583217 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
Jun 25 18:43:06.586025 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Jun 25 18:43:06.587039 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Jun 25 18:43:06.589239 systemd-journald[1118]: Time spent on flushing to /var/log/journal/6f50f9ae1ffb46618c48d0fd3ecf5079 is 12.728ms for 918 entries.
Jun 25 18:43:06.589239 systemd-journald[1118]: System Journal (/var/log/journal/6f50f9ae1ffb46618c48d0fd3ecf5079) is 8.0M, max 195.6M, 187.6M free.
Jun 25 18:43:06.611224 systemd-journald[1118]: Received client request to flush runtime journal.
Jun 25 18:43:06.591293 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
Jun 25 18:43:06.594882 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Jun 25 18:43:06.601330 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Jun 25 18:43:06.608629 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
Jun 25 18:43:06.610198 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
Jun 25 18:43:06.611869 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
Jun 25 18:43:06.615412 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
Jun 25 18:43:06.622552 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
Jun 25 18:43:06.626834 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
Jun 25 18:43:06.632955 kernel: loop0: detected capacity change from 0 to 139760
Jun 25 18:43:06.635210 kernel: block loop0: the capability attribute has been deprecated.
Jun 25 18:43:06.636138 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk...
Jun 25 18:43:06.640432 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
Jun 25 18:43:06.643016 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Jun 25 18:43:06.650657 systemd-tmpfiles[1163]: ACLs are not supported, ignoring.
Jun 25 18:43:06.650679 systemd-tmpfiles[1163]: ACLs are not supported, ignoring.
Jun 25 18:43:06.655216 udevadm[1175]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Jun 25 18:43:06.659511 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jun 25 18:43:06.663956 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jun 25 18:43:06.670216 systemd[1]: Starting systemd-sysusers.service - Create System Users...
Jun 25 18:43:06.672528 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Jun 25 18:43:06.673501 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk.
Jun 25 18:43:06.699956 kernel: loop1: detected capacity change from 0 to 80568
Jun 25 18:43:06.702200 systemd[1]: Finished systemd-sysusers.service - Create System Users.
Jun 25 18:43:06.713248 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Jun 25 18:43:06.733014 systemd-tmpfiles[1184]: ACLs are not supported, ignoring.
Jun 25 18:43:06.733036 systemd-tmpfiles[1184]: ACLs are not supported, ignoring.
Jun 25 18:43:06.739241 kernel: loop2: detected capacity change from 0 to 139760
Jun 25 18:43:06.739948 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jun 25 18:43:06.758055 kernel: loop3: detected capacity change from 0 to 80568
Jun 25 18:43:06.763947 (sd-merge)[1187]: Using extensions 'containerd-flatcar', 'docker-flatcar'.
Jun 25 18:43:06.765062 (sd-merge)[1187]: Merged extensions into '/usr'.
Jun 25 18:43:06.769916 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
Jun 25 18:43:06.778796 systemd[1]: Starting ensure-sysext.service...
Jun 25 18:43:06.782966 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories...
Jun 25 18:43:06.794498 systemd[1]: Reloading requested from client PID 1190 ('systemctl') (unit ensure-sysext.service)...
Jun 25 18:43:06.794682 systemd[1]: Reloading...
Jun 25 18:43:06.810711 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Jun 25 18:43:06.811154 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
Jun 25 18:43:06.812238 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Jun 25 18:43:06.812594 systemd-tmpfiles[1191]: ACLs are not supported, ignoring.
Jun 25 18:43:06.812665 systemd-tmpfiles[1191]: ACLs are not supported, ignoring.
Jun 25 18:43:06.816228 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot.
Jun 25 18:43:06.816240 systemd-tmpfiles[1191]: Skipping /boot
Jun 25 18:43:06.829716 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot.
Jun 25 18:43:06.829729 systemd-tmpfiles[1191]: Skipping /boot
Jun 25 18:43:06.860965 zram_generator::config[1217]: No configuration found.
Jun 25 18:43:06.956616 ldconfig[1157]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Jun 25 18:43:06.999131 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.
Jun 25 18:43:07.048630 systemd[1]: Reloading finished in 253 ms.
Jun 25 18:43:07.088922 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
Jun 25 18:43:07.095327 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories.
Jun 25 18:43:07.102559 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
Jun 25 18:43:07.105176 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
Jun 25 18:43:07.108243 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
Jun 25 18:43:07.115152 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Jun 25 18:43:07.121114 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
Jun 25 18:43:07.127177 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
Jun 25 18:43:07.134409 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
Jun 25 18:43:07.140718 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:07.140915 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jun 25 18:43:07.144523 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jun 25 18:43:07.148142 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jun 25 18:43:07.154367 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jun 25 18:43:07.155730 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jun 25 18:43:07.155863 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:07.156866 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
Jun 25 18:43:07.158754 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jun 25 18:43:07.158982 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jun 25 18:43:07.160633 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jun 25 18:43:07.160804 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jun 25 18:43:07.162476 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jun 25 18:43:07.162688 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jun 25 18:43:07.170667 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:07.170956 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jun 25 18:43:07.182183 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jun 25 18:43:07.186233 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Jun 25 18:43:07.187680 augenrules[1287]: No rules
Jun 25 18:43:07.191654 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jun 25 18:43:07.194453 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jun 25 18:43:07.196147 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jun 25 18:43:07.196286 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
Jun 25 18:43:07.197202 systemd[1]: Started systemd-userdbd.service - User Database Manager.
Jun 25 18:43:07.199360 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
Jun 25 18:43:07.201466 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jun 25 18:43:07.202004 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jun 25 18:43:07.204349 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jun 25 18:43:07.204689 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jun 25 18:43:07.210124 systemd[1]: modprobe@drm.service: Deactivated successfully.
Jun 25 18:43:07.210328 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Jun 25 18:43:07.212807 systemd[1]: Finished ensure-sysext.service.
Jun 25 18:43:07.214192 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jun 25 18:43:07.214375 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jun 25 18:43:07.221398 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Jun 25 18:43:07.221514 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Jun 25 18:43:07.231141 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
Jun 25 18:43:07.233427 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
Jun 25 18:43:07.235143 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
Jun 25 18:43:07.240088 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jun 25 18:43:07.243675 systemd[1]: Starting systemd-update-done.service - Update is Completed...
Jun 25 18:43:07.244824 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).
Jun 25 18:43:07.261396 systemd[1]: Finished systemd-update-done.service - Update is Completed.
Jun 25 18:43:07.263037 systemd-resolved[1261]: Positive Trust Anchors:
Jun 25 18:43:07.263052 systemd-resolved[1261]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jun 25 18:43:07.263083 systemd-resolved[1261]: 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 corp home internal intranet lan local private test
Jun 25 18:43:07.266395 systemd-resolved[1261]: Defaulting to hostname 'linux'.
Jun 25 18:43:07.268062 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Jun 25 18:43:07.269268 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Jun 25 18:43:07.274970 systemd-udevd[1308]: Using default interface naming scheme 'v255'.
Jun 25 18:43:07.289680 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
Jun 25 18:43:07.291221 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jun 25 18:43:07.292926 systemd[1]: Reached target time-set.target - System Time Set.
Jun 25 18:43:07.303668 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Jun 25 18:43:07.330268 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
Jun 25 18:43:07.333944 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1321)
Jun 25 18:43:07.350012 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1319)
Jun 25 18:43:07.356952 systemd-networkd[1322]: lo: Link UP
Jun 25 18:43:07.356962 systemd-networkd[1322]: lo: Gained carrier
Jun 25 18:43:07.359279 systemd-networkd[1322]: Enumeration completed
Jun 25 18:43:07.359405 systemd[1]: Started systemd-networkd.service - Network Configuration.
Jun 25 18:43:07.360741 systemd[1]: Reached target network.target - Network.
Jun 25 18:43:07.361132 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jun 25 18:43:07.361137 systemd-networkd[1322]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jun 25 18:43:07.362013 systemd-networkd[1322]: eth0: Link UP
Jun 25 18:43:07.362017 systemd-networkd[1322]: eth0: Gained carrier
Jun 25 18:43:07.362029 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jun 25 18:43:07.370097 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
Jun 25 18:43:07.377022 systemd-networkd[1322]: eth0: DHCPv4 address 10.0.0.127/16, gateway 10.0.0.1 acquired from 10.0.0.1
Jun 25 18:43:07.377822 systemd-timesyncd[1305]: Network configuration changed, trying to establish connection.
Jun 25 18:43:07.926685 systemd-timesyncd[1305]: Contacted time server 10.0.0.1:123 (10.0.0.1).
Jun 25 18:43:07.926757 systemd-timesyncd[1305]: Initial clock synchronization to Tue 2024-06-25 18:43:07.926596 UTC.
Jun 25 18:43:07.926923 systemd-resolved[1261]: Clock change detected. Flushing caches.
Jun 25 18:43:07.930314 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jun 25 18:43:07.933265 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
Jun 25 18:43:07.939431 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
Jun 25 18:43:07.947765 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
Jun 25 18:43:07.947842 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
Jun 25 18:43:07.951819 kernel: ACPI: button: Power Button [PWRF]
Jun 25 18:43:07.957354 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
Jun 25 18:43:07.965755 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
Jun 25 18:43:07.992768 kernel: mousedev: PS/2 mouse device common for all mice
Jun 25 18:43:08.002969 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jun 25 18:43:08.075781 kernel: kvm_amd: TSC scaling supported
Jun 25 18:43:08.076037 kernel: kvm_amd: Nested Virtualization enabled
Jun 25 18:43:08.076090 kernel: kvm_amd: Nested Paging enabled
Jun 25 18:43:08.076128 kernel: kvm_amd: LBR virtualization supported
Jun 25 18:43:08.076165 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported
Jun 25 18:43:08.076202 kernel: kvm_amd: Virtual GIF supported
Jun 25 18:43:08.091852 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jun 25 18:43:08.098966 kernel: EDAC MC: Ver: 3.0.0
Jun 25 18:43:08.134099 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
Jun 25 18:43:08.145888 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
Jun 25 18:43:08.156496 lvm[1356]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jun 25 18:43:08.193088 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
Jun 25 18:43:08.194636 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Jun 25 18:43:08.195806 systemd[1]: Reached target sysinit.target - System Initialization.
Jun 25 18:43:08.196997 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
Jun 25 18:43:08.198267 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
Jun 25 18:43:08.199688 systemd[1]: Started logrotate.timer - Daily rotation of log files.
Jun 25 18:43:08.200958 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
Jun 25 18:43:08.202345 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
Jun 25 18:43:08.203667 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Jun 25 18:43:08.203701 systemd[1]: Reached target paths.target - Path Units.
Jun 25 18:43:08.204631 systemd[1]: Reached target timers.target - Timer Units.
Jun 25 18:43:08.206419 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
Jun 25 18:43:08.209286 systemd[1]: Starting docker.socket - Docker Socket for the API...
Jun 25 18:43:08.226251 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
Jun 25 18:43:08.228542 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
Jun 25 18:43:08.230085 systemd[1]: Listening on docker.socket - Docker Socket for the API.
Jun 25 18:43:08.231306 systemd[1]: Reached target sockets.target - Socket Units.
Jun 25 18:43:08.232437 systemd[1]: Reached target basic.target - Basic System.
Jun 25 18:43:08.233556 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
Jun 25 18:43:08.233581 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
Jun 25 18:43:08.234550 systemd[1]: Starting containerd.service - containerd container runtime...
Jun 25 18:43:08.236574 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
Jun 25 18:43:08.240703 lvm[1360]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jun 25 18:43:08.240783 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
Jun 25 18:43:08.244822 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
Jun 25 18:43:08.247051 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).
Jun 25 18:43:08.249679 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
Jun 25 18:43:08.250592 jq[1363]: false
Jun 25 18:43:08.252883 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
Jun 25 18:43:08.256625 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
Jun 25 18:43:08.263882 systemd[1]: Starting systemd-logind.service - User Login Management...
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found loop2
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found loop3
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found sr0
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda1
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda2
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda3
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found usr
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda4
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda6
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda7
Jun 25 18:43:08.272209 extend-filesystems[1364]: Found vda9
Jun 25 18:43:08.272209 extend-filesystems[1364]: Checking size of /dev/vda9
Jun 25 18:43:08.265320 dbus-daemon[1362]: [system] SELinux support is enabled
Jun 25 18:43:08.308062 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1330)
Jun 25 18:43:08.265878 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Jun 25 18:43:08.308161 extend-filesystems[1364]: Old size kept for /dev/vda9
Jun 25 18:43:08.266287 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Jun 25 18:43:08.268833 systemd[1]: Starting update-engine.service - Update Engine...
Jun 25 18:43:08.319744 jq[1378]: true
Jun 25 18:43:08.271016 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
Jun 25 18:43:08.273109 systemd[1]: Started dbus.service - D-Bus System Message Bus.
Jun 25 18:43:08.277383 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
Jun 25 18:43:08.282144 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Jun 25 18:43:08.320329 jq[1385]: true
Jun 25 18:43:08.282383 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
Jun 25 18:43:08.282733 systemd[1]: motdgen.service: Deactivated successfully.
Jun 25 18:43:08.282925 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
Jun 25 18:43:08.283749 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Jun 25 18:43:08.283935 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
Jun 25 18:43:08.295559 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).
Jun 25 18:43:08.295601 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
Jun 25 18:43:08.298267 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).
Jun 25 18:43:08.298292 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
Jun 25 18:43:08.308196 systemd[1]: extend-filesystems.service: Deactivated successfully.
Jun 25 18:43:08.309235 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
Jun 25 18:43:08.309425 (ntainerd)[1386]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
Jun 25 18:43:08.328063 update_engine[1375]: I0625 18:43:08.323643  1375 main.cc:92] Flatcar Update Engine starting
Jun 25 18:43:08.328063 update_engine[1375]: I0625 18:43:08.324944  1375 update_check_scheduler.cc:74] Next update check in 2m18s
Jun 25 18:43:08.342964 systemd-logind[1371]: Watching system buttons on /dev/input/event1 (Power Button)
Jun 25 18:43:08.342990 systemd-logind[1371]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
Jun 25 18:43:08.344490 systemd-logind[1371]: New seat seat0.
Jun 25 18:43:08.344961 systemd[1]: Started update-engine.service - Update Engine.
Jun 25 18:43:08.348018 systemd[1]: Started systemd-logind.service - User Login Management.
Jun 25 18:43:08.357940 systemd[1]: Started locksmithd.service - Cluster reboot manager.
Jun 25 18:43:08.379813 bash[1412]: Updated "/home/core/.ssh/authorized_keys"
Jun 25 18:43:08.381936 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
Jun 25 18:43:08.383967 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
Jun 25 18:43:08.387131 locksmithd[1411]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Jun 25 18:43:08.503214 containerd[1386]: time="2024-06-25T18:43:08.503125333Z" level=info msg="starting containerd" revision=cd7148ac666309abf41fd4a49a8a5895b905e7f3 version=v1.7.18
Jun 25 18:43:08.524990 containerd[1386]: time="2024-06-25T18:43:08.524942461Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jun 25 18:43:08.524990 containerd[1386]: time="2024-06-25T18:43:08.524987575Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527051 containerd[1386]: time="2024-06-25T18:43:08.526963229Z" 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.35-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527051 containerd[1386]: time="2024-06-25T18:43:08.527041176Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527436 containerd[1386]: time="2024-06-25T18:43:08.527401341Z" 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
Jun 25 18:43:08.527436 containerd[1386]: time="2024-06-25T18:43:08.527430997Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jun 25 18:43:08.527572 containerd[1386]: time="2024-06-25T18:43:08.527545682Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527684 containerd[1386]: time="2024-06-25T18:43:08.527648695Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527684 containerd[1386]: time="2024-06-25T18:43:08.527679653Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.527822 containerd[1386]: time="2024-06-25T18:43:08.527797814Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.528100 containerd[1386]: time="2024-06-25T18:43:08.528073822Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.528121 containerd[1386]: time="2024-06-25T18:43:08.528098358Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Jun 25 18:43:08.528121 containerd[1386]: time="2024-06-25T18:43:08.528109659Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jun 25 18:43:08.528280 containerd[1386]: time="2024-06-25T18:43:08.528251545Z" 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
Jun 25 18:43:08.528280 containerd[1386]: time="2024-06-25T18:43:08.528273246Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jun 25 18:43:08.528368 containerd[1386]: time="2024-06-25T18:43:08.528341985Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Jun 25 18:43:08.528390 containerd[1386]: time="2024-06-25T18:43:08.528364266Z" level=info msg="metadata content store policy set" policy=shared
Jun 25 18:43:08.534233 containerd[1386]: time="2024-06-25T18:43:08.534190911Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jun 25 18:43:08.534233 containerd[1386]: time="2024-06-25T18:43:08.534233972Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jun 25 18:43:08.534305 containerd[1386]: time="2024-06-25T18:43:08.534251866Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jun 25 18:43:08.534305 containerd[1386]: time="2024-06-25T18:43:08.534290518Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jun 25 18:43:08.534342 containerd[1386]: time="2024-06-25T18:43:08.534310946Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jun 25 18:43:08.534342 containerd[1386]: time="2024-06-25T18:43:08.534325313Z" level=info msg="NRI interface is disabled by configuration."
Jun 25 18:43:08.534394 containerd[1386]: time="2024-06-25T18:43:08.534341674Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jun 25 18:43:08.534532 containerd[1386]: time="2024-06-25T18:43:08.534503948Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jun 25 18:43:08.534554 containerd[1386]: time="2024-06-25T18:43:08.534531570Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jun 25 18:43:08.534573 containerd[1386]: time="2024-06-25T18:43:08.534549524Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jun 25 18:43:08.534573 containerd[1386]: time="2024-06-25T18:43:08.534567147Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jun 25 18:43:08.534615 containerd[1386]: time="2024-06-25T18:43:08.534593166Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534637 containerd[1386]: time="2024-06-25T18:43:08.534615728Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534662 containerd[1386]: time="2024-06-25T18:43:08.534635755Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534662 containerd[1386]: time="2024-06-25T18:43:08.534655613Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534710 containerd[1386]: time="2024-06-25T18:43:08.534673997Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534730 containerd[1386]: time="2024-06-25T18:43:08.534707760Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534730 containerd[1386]: time="2024-06-25T18:43:08.534725624Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.534766 containerd[1386]: time="2024-06-25T18:43:08.534741414Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jun 25 18:43:08.534903 containerd[1386]: time="2024-06-25T18:43:08.534875495Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jun 25 18:43:08.535201 containerd[1386]: time="2024-06-25T18:43:08.535174496Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jun 25 18:43:08.535229 containerd[1386]: time="2024-06-25T18:43:08.535211405Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535255 containerd[1386]: time="2024-06-25T18:43:08.535230671Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jun 25 18:43:08.535275 containerd[1386]: time="2024-06-25T18:43:08.535257070Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jun 25 18:43:08.535352 containerd[1386]: time="2024-06-25T18:43:08.535329186Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535373 containerd[1386]: time="2024-06-25T18:43:08.535350646Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535373 containerd[1386]: time="2024-06-25T18:43:08.535368409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535415 containerd[1386]: time="2024-06-25T18:43:08.535383858Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535415 containerd[1386]: time="2024-06-25T18:43:08.535400479Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535451 containerd[1386]: time="2024-06-25T18:43:08.535416089Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535451 containerd[1386]: time="2024-06-25T18:43:08.535432640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535487 containerd[1386]: time="2024-06-25T18:43:08.535448229Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535487 containerd[1386]: time="2024-06-25T18:43:08.535464860Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jun 25 18:43:08.535668 containerd[1386]: time="2024-06-25T18:43:08.535641451Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535704 containerd[1386]: time="2024-06-25T18:43:08.535667901Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535748 containerd[1386]: time="2024-06-25T18:43:08.535728655Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535777 containerd[1386]: time="2024-06-25T18:43:08.535762819Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535797 containerd[1386]: time="2024-06-25T18:43:08.535781373Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535817 containerd[1386]: time="2024-06-25T18:43:08.535798796Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535842 containerd[1386]: time="2024-06-25T18:43:08.535814305Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.535842 containerd[1386]: time="2024-06-25T18:43:08.535829464Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Jun 25 18:43:08.536239 containerd[1386]: time="2024-06-25T18:43:08.536165484Z" 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}"
Jun 25 18:43:08.536239 containerd[1386]: time="2024-06-25T18:43:08.536242328Z" level=info msg="Connect containerd service"
Jun 25 18:43:08.536384 containerd[1386]: time="2024-06-25T18:43:08.536270360Z" level=info msg="using legacy CRI server"
Jun 25 18:43:08.536384 containerd[1386]: time="2024-06-25T18:43:08.536279087Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
Jun 25 18:43:08.536384 containerd[1386]: time="2024-06-25T18:43:08.536367993Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Jun 25 18:43:08.537188 containerd[1386]: time="2024-06-25T18:43:08.537155019Z" 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"
Jun 25 18:43:08.537234 containerd[1386]: time="2024-06-25T18:43:08.537213529Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jun 25 18:43:08.537256 containerd[1386]: time="2024-06-25T18:43:08.537240880Z" 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
Jun 25 18:43:08.537285 containerd[1386]: time="2024-06-25T18:43:08.537256339Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jun 25 18:43:08.537285 containerd[1386]: time="2024-06-25T18:43:08.537272119Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jun 25 18:43:08.537540 containerd[1386]: time="2024-06-25T18:43:08.537493303Z" level=info msg="Start subscribing containerd event"
Jun 25 18:43:08.537563 containerd[1386]: time="2024-06-25T18:43:08.537548557Z" level=info msg="Start recovering state"
Jun 25 18:43:08.537641 containerd[1386]: time="2024-06-25T18:43:08.537618187Z" level=info msg="Start event monitor"
Jun 25 18:43:08.537664 containerd[1386]: time="2024-06-25T18:43:08.537649386Z" level=info msg="Start snapshots syncer"
Jun 25 18:43:08.537683 containerd[1386]: time="2024-06-25T18:43:08.537661559Z" level=info msg="Start cni network conf syncer for default"
Jun 25 18:43:08.537683 containerd[1386]: time="2024-06-25T18:43:08.537671578Z" level=info msg="Start streaming server"
Jun 25 18:43:08.538024 containerd[1386]: time="2024-06-25T18:43:08.537988301Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Jun 25 18:43:08.538106 containerd[1386]: time="2024-06-25T18:43:08.538082658Z" level=info msg=serving... address=/run/containerd/containerd.sock
Jun 25 18:43:08.538206 containerd[1386]: time="2024-06-25T18:43:08.538175292Z" level=info msg="containerd successfully booted in 0.036362s"
Jun 25 18:43:08.538273 systemd[1]: Started containerd.service - containerd container runtime.
Jun 25 18:43:08.609568 sshd_keygen[1381]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Jun 25 18:43:08.635752 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
Jun 25 18:43:08.648950 systemd[1]: Starting issuegen.service - Generate /run/issue...
Jun 25 18:43:08.657554 systemd[1]: issuegen.service: Deactivated successfully.
Jun 25 18:43:08.657845 systemd[1]: Finished issuegen.service - Generate /run/issue.
Jun 25 18:43:08.661036 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
Jun 25 18:43:08.679238 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
Jun 25 18:43:08.682499 systemd[1]: Started getty@tty1.service - Getty on tty1.
Jun 25 18:43:08.684849 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
Jun 25 18:43:08.686229 systemd[1]: Reached target getty.target - Login Prompts.
Jun 25 18:43:08.937067 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
Jun 25 18:43:08.939913 systemd[1]: Started sshd@0-10.0.0.127:22-10.0.0.1:37630.service - OpenSSH per-connection server daemon (10.0.0.1:37630).
Jun 25 18:43:08.992901 sshd[1445]: Accepted publickey for core from 10.0.0.1 port 37630 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:08.994745 sshd[1445]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:09.003397 systemd-logind[1371]: New session 1 of user core.
Jun 25 18:43:09.004783 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
Jun 25 18:43:09.014917 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
Jun 25 18:43:09.027200 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
Jun 25 18:43:09.041921 systemd[1]: Starting user@500.service - User Manager for UID 500...
Jun 25 18:43:09.045621 (systemd)[1449]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:09.156310 systemd[1449]: Queued start job for default target default.target.
Jun 25 18:43:09.168014 systemd[1449]: Created slice app.slice - User Application Slice.
Jun 25 18:43:09.168042 systemd[1449]: Reached target paths.target - Paths.
Jun 25 18:43:09.168059 systemd[1449]: Reached target timers.target - Timers.
Jun 25 18:43:09.169547 systemd[1449]: Starting dbus.socket - D-Bus User Message Bus Socket...
Jun 25 18:43:09.181343 systemd[1449]: Listening on dbus.socket - D-Bus User Message Bus Socket.
Jun 25 18:43:09.181498 systemd[1449]: Reached target sockets.target - Sockets.
Jun 25 18:43:09.181519 systemd[1449]: Reached target basic.target - Basic System.
Jun 25 18:43:09.181566 systemd[1449]: Reached target default.target - Main User Target.
Jun 25 18:43:09.181602 systemd[1449]: Startup finished in 129ms.
Jun 25 18:43:09.181937 systemd[1]: Started user@500.service - User Manager for UID 500.
Jun 25 18:43:09.184679 systemd[1]: Started session-1.scope - Session 1 of User core.
Jun 25 18:43:09.248965 systemd[1]: Started sshd@1-10.0.0.127:22-10.0.0.1:37640.service - OpenSSH per-connection server daemon (10.0.0.1:37640).
Jun 25 18:43:09.289869 sshd[1460]: Accepted publickey for core from 10.0.0.1 port 37640 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:09.291638 sshd[1460]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:09.295277 systemd-logind[1371]: New session 2 of user core.
Jun 25 18:43:09.303832 systemd[1]: Started session-2.scope - Session 2 of User core.
Jun 25 18:43:09.358500 sshd[1460]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:09.375440 systemd[1]: sshd@1-10.0.0.127:22-10.0.0.1:37640.service: Deactivated successfully.
Jun 25 18:43:09.377111 systemd[1]: session-2.scope: Deactivated successfully.
Jun 25 18:43:09.378639 systemd-logind[1371]: Session 2 logged out. Waiting for processes to exit.
Jun 25 18:43:09.379893 systemd[1]: Started sshd@2-10.0.0.127:22-10.0.0.1:37648.service - OpenSSH per-connection server daemon (10.0.0.1:37648).
Jun 25 18:43:09.381918 systemd-logind[1371]: Removed session 2.
Jun 25 18:43:09.418084 sshd[1467]: Accepted publickey for core from 10.0.0.1 port 37648 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:09.419473 sshd[1467]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:09.423211 systemd-logind[1371]: New session 3 of user core.
Jun 25 18:43:09.434803 systemd[1]: Started session-3.scope - Session 3 of User core.
Jun 25 18:43:09.488765 sshd[1467]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:09.492377 systemd[1]: sshd@2-10.0.0.127:22-10.0.0.1:37648.service: Deactivated successfully.
Jun 25 18:43:09.494388 systemd[1]: session-3.scope: Deactivated successfully.
Jun 25 18:43:09.494918 systemd-logind[1371]: Session 3 logged out. Waiting for processes to exit.
Jun 25 18:43:09.495805 systemd-logind[1371]: Removed session 3.
Jun 25 18:43:09.762834 systemd-networkd[1322]: eth0: Gained IPv6LL
Jun 25 18:43:09.765843 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
Jun 25 18:43:09.767560 systemd[1]: Reached target network-online.target - Network is Online.
Jun 25 18:43:09.780888 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
Jun 25 18:43:09.782927 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
Jun 25 18:43:09.802824 systemd[1]: coreos-metadata.service: Deactivated successfully.
Jun 25 18:43:09.803139 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
Jun 25 18:43:09.806141 systemd[1]: Starting etcd-member.service - etcd (System Application Container)...
Jun 25 18:43:09.807341 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
Jun 25 18:43:09.807881 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
Jun 25 18:43:09.812993 (-wrapper)[1486]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS
Jun 25 18:43:09.929979 systemd[1]: Starting docker.service - Docker Application Container Engine...
Jun 25 18:43:09.931269 (dockerd)[1497]: 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
Jun 25 18:43:10.168658 dockerd[1497]: time="2024-06-25T18:43:10.168519046Z" level=info msg="Starting up"
Jun 25 18:43:10.206829 systemd[1]: var-lib-docker-metacopy\x2dcheck705022116-merged.mount: Deactivated successfully.
Jun 25 18:43:10.230658 dockerd[1497]: time="2024-06-25T18:43:10.230600900Z" level=info msg="Loading containers: start."
Jun 25 18:43:10.348769 kernel: Initializing XFRM netlink socket
Jun 25 18:43:10.430531 systemd-networkd[1322]: docker0: Link UP
Jun 25 18:43:10.450566 dockerd[1497]: time="2024-06-25T18:43:10.450516662Z" level=info msg="Loading containers: done."
Jun 25 18:43:10.499892 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1550034870-merged.mount: Deactivated successfully.
Jun 25 18:43:10.501956 dockerd[1497]: time="2024-06-25T18:43:10.501876131Z" 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
Jun 25 18:43:10.502171 dockerd[1497]: time="2024-06-25T18:43:10.502141849Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9
Jun 25 18:43:10.502327 dockerd[1497]: time="2024-06-25T18:43:10.502299514Z" level=info msg="Daemon has completed initialization"
Jun 25 18:43:10.539617 dockerd[1497]: time="2024-06-25T18:43:10.539544058Z" level=info msg="API listen on /run/docker.sock"
Jun 25 18:43:10.539800 systemd[1]: Started docker.service - Docker Application Container Engine.
Jun 25 18:43:10.541055 etcd-wrapper[1491]: Error response from daemon: No such container: etcd-member
Jun 25 18:43:10.556181 etcd-wrapper[1610]: Error response from daemon: No such container: etcd-member
Jun 25 18:43:10.585472 etcd-wrapper[1628]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally
Jun 25 18:43:11.812755 etcd-wrapper[1628]: v3.5.0: Pulling from coreos/etcd
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 1813d21adc01: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 6e96907ab677: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 444ed0ea8673: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 0fd2df5633f0: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 8cc22b9456bb: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 7ac70aecd290: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 4b376c64dfe4: Pulling fs layer
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 8cc22b9456bb: Waiting
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 7ac70aecd290: Waiting
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 4b376c64dfe4: Waiting
Jun 25 18:43:12.136428 etcd-wrapper[1628]: 0fd2df5633f0: Waiting
Jun 25 18:43:12.492206 etcd-wrapper[1628]: 444ed0ea8673: Download complete
Jun 25 18:43:12.494364 etcd-wrapper[1628]: 6e96907ab677: Verifying Checksum
Jun 25 18:43:12.494364 etcd-wrapper[1628]: 6e96907ab677: Download complete
Jun 25 18:43:12.598222 etcd-wrapper[1628]: 1813d21adc01: Verifying Checksum
Jun 25 18:43:12.598222 etcd-wrapper[1628]: 1813d21adc01: Download complete
Jun 25 18:43:12.793548 etcd-wrapper[1628]: 8cc22b9456bb: Verifying Checksum
Jun 25 18:43:12.793548 etcd-wrapper[1628]: 8cc22b9456bb: Download complete
Jun 25 18:43:12.828155 etcd-wrapper[1628]: 0fd2df5633f0: Verifying Checksum
Jun 25 18:43:12.828155 etcd-wrapper[1628]: 0fd2df5633f0: Download complete
Jun 25 18:43:12.900930 etcd-wrapper[1628]: 7ac70aecd290: Verifying Checksum
Jun 25 18:43:12.900930 etcd-wrapper[1628]: 7ac70aecd290: Download complete
Jun 25 18:43:13.087083 etcd-wrapper[1628]: 4b376c64dfe4: Verifying Checksum
Jun 25 18:43:13.087083 etcd-wrapper[1628]: 4b376c64dfe4: Download complete
Jun 25 18:43:13.332807 etcd-wrapper[1628]: 1813d21adc01: Pull complete
Jun 25 18:43:13.489952 systemd[1]: var-lib-docker-overlay2-31209cef0810e97637798fd9b97bfb6353da6ad15742206e6f8563626666376c-merged.mount: Deactivated successfully.
Jun 25 18:43:13.803206 etcd-wrapper[1628]: 6e96907ab677: Pull complete
Jun 25 18:43:13.914303 systemd[1]: var-lib-docker-overlay2-74c872d0dc32ec4632f6995816fbe505f2a8f06f9b8cbe885ac91f8c76ced4cb-merged.mount: Deactivated successfully.
Jun 25 18:43:13.983178 etcd-wrapper[1628]: 444ed0ea8673: Pull complete
Jun 25 18:43:14.144279 etcd-wrapper[1628]: 0fd2df5633f0: Pull complete
Jun 25 18:43:14.167382 etcd-wrapper[1628]: 8cc22b9456bb: Pull complete
Jun 25 18:43:14.189935 etcd-wrapper[1628]: 7ac70aecd290: Pull complete
Jun 25 18:43:14.212240 etcd-wrapper[1628]: 4b376c64dfe4: Pull complete
Jun 25 18:43:14.220889 etcd-wrapper[1628]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b
Jun 25 18:43:14.223823 etcd-wrapper[1628]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0
Jun 25 18:43:14.342948 containerd[1386]: time="2024-06-25T18:43:14.342833294Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jun 25 18:43:14.342948 containerd[1386]: time="2024-06-25T18:43:14.342908605Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jun 25 18:43:14.342948 containerd[1386]: time="2024-06-25T18:43:14.342925066Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jun 25 18:43:14.342948 containerd[1386]: time="2024-06-25T18:43:14.342936087Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jun 25 18:43:14.346356 systemd[1]: var-lib-docker-overlay2-94b51c7a9b5998ef87a74eed4d91723f858a6ba0fe473d431e1e13a5c9d6d8e7-merged.mount: Deactivated successfully.
Jun 25 18:43:14.367849 systemd[1]: Started docker-6c22a321462525ef37ca86563a618940e99d7b1f95fd32ee85de898c44147843.scope - libcontainer container 6c22a321462525ef37ca86563a618940e99d7b1f95fd32ee85de898c44147843.
Jun 25 18:43:14.382235 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"info","ts":1719340994.4194849,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"info","ts":1719340994.4195635,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"6f50f9ae1ffb46618c48d0fd3ecf5079"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"warn","ts":1719340994.4195912,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"warn","ts":1719340994.419605,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"warn","ts":1719340994.4196112,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"warn","ts":1719340994.4196162,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.419Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.127:2379"]}
Jun 25 18:43:14.420372 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.419Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]}
Jun 25 18:43:14.422727 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.420Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]}
Jun 25 18:43:14.422727 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.420Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"6f50f9ae1ffb46618c48d0fd3ecf5079","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.127:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"6f50f9ae1ffb46618c48d0fd3ecf5079=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
Jun 25 18:43:14.423058 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.422Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.582167ms"}
Jun 25 18:43:14.429808 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.429Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"}
Jun 25 18:43:14.430008 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"}
Jun 25 18:43:14.430008 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"}
Jun 25 18:43:14.430472 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.430Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
Jun 25 18:43:14.430472 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.430Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"}
Jun 25 18:43:14.430472 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.430Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
Jun 25 18:43:14.432111 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:43:14.431Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"}
Jun 25 18:43:14.433741 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.433Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1}
Jun 25 18:43:14.434588 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.434Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
Jun 25 18:43:14.435833 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.435Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.0","cluster-version":"to_be_decided"}
Jun 25 18:43:14.435833 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.435Z","caller":"etcdserver/server.go:728","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
Jun 25 18:43:14.436826 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
Jun 25 18:43:14.436826 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.436Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]}
Jun 25 18:43:14.438506 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.438Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.127:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]}
Jun 25 18:43:14.438587 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.438Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"127.0.0.1:2380"}
Jun 25 18:43:14.438587 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.438Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"127.0.0.1:2380"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.630Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"}
Jun 25 18:43:14.631346 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"}
Jun 25 18:43:14.631719 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:6f50f9ae1ffb46618c48d0fd3ecf5079 ClientURLs:[http://10.0.0.127:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"}
Jun 25 18:43:14.631719 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"}
Jun 25 18:43:14.631719 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","caller":"etcdserver/server.go:2476","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
Jun 25 18:43:14.631822 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"}
Jun 25 18:43:14.632434 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.631Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"}
Jun 25 18:43:14.632206 systemd[1]: Started etcd-member.service - etcd (System Application Container).
Jun 25 18:43:14.632833 systemd[1]: Reached target multi-user.target - Multi-User System.
Jun 25 18:43:14.632934 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.632Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"}
Jun 25 18:43:14.632934 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.632Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"}
Jun 25 18:43:14.632934 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
Jun 25 18:43:14.632934 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:43:14.632Z","caller":"etcdserver/server.go:2500","msg":"cluster version is updated","cluster-version":"3.5"}
Jun 25 18:43:14.633113 systemd[1]: Startup finished in 849ms (kernel) + 3.946s (initrd) + 8.449s (userspace) = 13.245s.
Jun 25 18:43:19.501544 systemd[1]: Started sshd@3-10.0.0.127:22-10.0.0.1:47862.service - OpenSSH per-connection server daemon (10.0.0.1:47862).
Jun 25 18:43:19.540816 sshd[1729]: Accepted publickey for core from 10.0.0.1 port 47862 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:19.542316 sshd[1729]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:19.546237 systemd-logind[1371]: New session 4 of user core.
Jun 25 18:43:19.555907 systemd[1]: Started session-4.scope - Session 4 of User core.
Jun 25 18:43:19.611069 sshd[1729]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:19.618940 systemd[1]: sshd@3-10.0.0.127:22-10.0.0.1:47862.service: Deactivated successfully.
Jun 25 18:43:19.620942 systemd[1]: session-4.scope: Deactivated successfully.
Jun 25 18:43:19.622647 systemd-logind[1371]: Session 4 logged out. Waiting for processes to exit.
Jun 25 18:43:19.636015 systemd[1]: Started sshd@4-10.0.0.127:22-10.0.0.1:47870.service - OpenSSH per-connection server daemon (10.0.0.1:47870).
Jun 25 18:43:19.637066 systemd-logind[1371]: Removed session 4.
Jun 25 18:43:19.672260 sshd[1736]: Accepted publickey for core from 10.0.0.1 port 47870 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:19.674019 sshd[1736]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:19.678285 systemd-logind[1371]: New session 5 of user core.
Jun 25 18:43:19.687855 systemd[1]: Started session-5.scope - Session 5 of User core.
Jun 25 18:43:19.738672 sshd[1736]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:19.759286 systemd[1]: sshd@4-10.0.0.127:22-10.0.0.1:47870.service: Deactivated successfully.
Jun 25 18:43:19.761546 systemd[1]: session-5.scope: Deactivated successfully.
Jun 25 18:43:19.762984 systemd-logind[1371]: Session 5 logged out. Waiting for processes to exit.
Jun 25 18:43:19.773120 systemd[1]: Started sshd@5-10.0.0.127:22-10.0.0.1:47880.service - OpenSSH per-connection server daemon (10.0.0.1:47880).
Jun 25 18:43:19.774319 systemd-logind[1371]: Removed session 5.
Jun 25 18:43:19.808970 sshd[1743]: Accepted publickey for core from 10.0.0.1 port 47880 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:19.810627 sshd[1743]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:19.814553 systemd-logind[1371]: New session 6 of user core.
Jun 25 18:43:19.824059 systemd[1]: Started session-6.scope - Session 6 of User core.
Jun 25 18:43:19.880498 sshd[1743]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:19.894094 systemd[1]: sshd@5-10.0.0.127:22-10.0.0.1:47880.service: Deactivated successfully.
Jun 25 18:43:19.896256 systemd[1]: session-6.scope: Deactivated successfully.
Jun 25 18:43:19.898129 systemd-logind[1371]: Session 6 logged out. Waiting for processes to exit.
Jun 25 18:43:19.909194 systemd[1]: Started sshd@6-10.0.0.127:22-10.0.0.1:47888.service - OpenSSH per-connection server daemon (10.0.0.1:47888).
Jun 25 18:43:19.910425 systemd-logind[1371]: Removed session 6.
Jun 25 18:43:19.945442 sshd[1751]: Accepted publickey for core from 10.0.0.1 port 47888 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:19.947442 sshd[1751]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:19.951631 systemd-logind[1371]: New session 7 of user core.
Jun 25 18:43:19.960908 systemd[1]: Started session-7.scope - Session 7 of User core.
Jun 25 18:43:20.013249 sshd[1751]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:20.032005 systemd[1]: sshd@6-10.0.0.127:22-10.0.0.1:47888.service: Deactivated successfully.
Jun 25 18:43:20.034113 systemd[1]: session-7.scope: Deactivated successfully.
Jun 25 18:43:20.035666 systemd-logind[1371]: Session 7 logged out. Waiting for processes to exit.
Jun 25 18:43:20.046203 systemd[1]: Started sshd@7-10.0.0.127:22-10.0.0.1:47890.service - OpenSSH per-connection server daemon (10.0.0.1:47890).
Jun 25 18:43:20.047230 systemd-logind[1371]: Removed session 7.
Jun 25 18:43:20.082340 sshd[1760]: Accepted publickey for core from 10.0.0.1 port 47890 ssh2: RSA SHA256:VbxkEvWvAYXm+csql9vHz/Q507SQa+IyrfABNJIeiWA
Jun 25 18:43:20.083911 sshd[1760]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jun 25 18:43:20.088032 systemd-logind[1371]: New session 8 of user core.
Jun 25 18:43:20.097855 systemd[1]: Started session-8.scope - Session 8 of User core.
Jun 25 18:43:20.190684 sshd[1760]: pam_unix(sshd:session): session closed for user core
Jun 25 18:43:20.194807 systemd[1]: sshd@7-10.0.0.127:22-10.0.0.1:47890.service: Deactivated successfully.
Jun 25 18:43:20.196810 systemd[1]: session-8.scope: Deactivated successfully.
Jun 25 18:43:20.197380 systemd-logind[1371]: Session 8 logged out. Waiting for processes to exit.
Jun 25 18:43:20.198283 systemd-logind[1371]: Removed session 8.
Jun 25 18:43:53.402913 update_engine[1375]: I0625 18:43:53.402796  1375 update_attempter.cc:509] Updating boot flags...
Jun 25 18:43:53.432722 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1781)
Jun 25 18:43:53.459730 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1780)
Jun 25 18:43:53.498722 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1780)
Jun 25 18:44:31.252564 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.252Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"133.314289ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7587879623507018177 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns-76f75df574-mbjgj.17dc53983ceaa88c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-76f75df574-mbjgj.17dc53983ceaa88c\" value_size:632 lease:7587879623507017745 >> failure:<>>","response":"size:16"}
Jun 25 18:44:31.252564 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.252Z","caller":"traceutil/trace.go:171","msg":"trace[560301870] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"180.449397ms","start":"2024-06-25T18:44:31.071Z","end":"2024-06-25T18:44:31.252Z","steps":["trace[560301870] 'process raft request'  (duration: 46.674073ms)","trace[560301870] 'compare'  (duration: 133.186018ms)"],"step_count":2}
Jun 25 18:44:31.537506 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.537Z","caller":"traceutil/trace.go:171","msg":"trace[100307860] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:430; }","duration":"196.103016ms","start":"2024-06-25T18:44:31.341Z","end":"2024-06-25T18:44:31.537Z","steps":["trace[100307860] 'read index received'  (duration: 196.098808ms)","trace[100307860] 'applied index is now lower than readState.Index'  (duration: 3.226µs)"],"step_count":2}
Jun 25 18:44:31.663455 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"321.965197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-76f75df574-9lc8z\" ","response":"range_response_count:1 size:3814"}
Jun 25 18:44:31.663455 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[1616988714] range","detail":"{range_begin:/registry/pods/kube-system/coredns-76f75df574-9lc8z; range_end:; response_count:1; response_revision:417; }","duration":"322.039146ms","start":"2024-06-25T18:44:31.341Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[1616988714] 'agreement among raft nodes before linearized reading'  (duration: 196.200629ms)","trace[1616988714] 'range keys from in-memory index tree'  (duration: 125.734482ms)"],"step_count":2}
Jun 25 18:44:31.663455 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2024-06-25T18:44:31.341Z","time spent":"322.098147ms","remote":"10.0.0.131:36728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3838,"request content":"key:\"/registry/pods/kube-system/coredns-76f75df574-9lc8z\" "}
Jun 25 18:44:31.663778 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"125.766261ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7587879623507018182 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/localhost\" mod_revision:312 > success:<request_put:<key:\"/registry/leases/kube-node-lease/localhost\" value_size:475 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/localhost\" > >>","response":"size:16"}
Jun 25 18:44:31.663778 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[903127922] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"126.045815ms","start":"2024-06-25T18:44:31.537Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[903127922] 'read index received'  (duration: 113.242234ms)","trace[903127922] 'applied index is now lower than readState.Index'  (duration: 12.802709ms)"],"step_count":2}
Jun 25 18:44:31.663778 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[424914287] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"223.28323ms","start":"2024-06-25T18:44:31.440Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[424914287] 'process raft request'  (duration: 97.242484ms)","trace[424914287] 'compare'  (duration: 125.701621ms)"],"step_count":2}
Jun 25 18:44:31.663778 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"127.528949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
Jun 25 18:44:31.663956 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[1604223189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"127.553376ms","start":"2024-06-25T18:44:31.535Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[1604223189] 'agreement among raft nodes before linearized reading'  (duration: 127.506938ms)"],"step_count":1}
Jun 25 18:44:31.663956 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.820942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
Jun 25 18:44:31.663956 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"319.655572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
Jun 25 18:44:31.663956 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[1967104623] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:418; }","duration":"106.845018ms","start":"2024-06-25T18:44:31.556Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[1967104623] 'agreement among raft nodes before linearized reading'  (duration: 106.807257ms)"],"step_count":1}
Jun 25 18:44:31.663956 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.717579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
Jun 25 18:44:31.664118 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[525856537] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:418; }","duration":"319.672064ms","start":"2024-06-25T18:44:31.343Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[525856537] 'agreement among raft nodes before linearized reading'  (duration: 319.640915ms)"],"step_count":1}
Jun 25 18:44:31.664118 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:44:31.663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2024-06-25T18:44:31.343Z","time spent":"319.723881ms","remote":"10.0.0.131:36828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
Jun 25 18:44:31.664118 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:31.663Z","caller":"traceutil/trace.go:171","msg":"trace[1336746418] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:418; }","duration":"106.767382ms","start":"2024-06-25T18:44:31.556Z","end":"2024-06-25T18:44:31.663Z","steps":["trace[1336746418] 'agreement among raft nodes before linearized reading'  (duration: 106.694626ms)"],"step_count":1}
Jun 25 18:44:37.730675 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:37.730Z","caller":"traceutil/trace.go:171","msg":"trace[1927194316] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"152.320449ms","start":"2024-06-25T18:44:37.577Z","end":"2024-06-25T18:44:37.730Z","steps":["trace[1927194316] 'process raft request'  (duration: 115.809573ms)","trace[1927194316] 'compare'  (duration: 36.334093ms)"],"step_count":2}
Jun 25 18:44:37.730675 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:37.730Z","caller":"traceutil/trace.go:171","msg":"trace[1125205611] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"150.554686ms","start":"2024-06-25T18:44:37.579Z","end":"2024-06-25T18:44:37.730Z","steps":["trace[1125205611] 'process raft request'  (duration: 150.476279ms)"],"step_count":1}
Jun 25 18:44:37.730675 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:37.730Z","caller":"traceutil/trace.go:171","msg":"trace[1764735522] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"151.048953ms","start":"2024-06-25T18:44:37.579Z","end":"2024-06-25T18:44:37.730Z","steps":["trace[1764735522] 'process raft request'  (duration: 150.905083ms)"],"step_count":1}
Jun 25 18:44:37.730675 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:37.730Z","caller":"traceutil/trace.go:171","msg":"trace[303880461] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"148.383031ms","start":"2024-06-25T18:44:37.581Z","end":"2024-06-25T18:44:37.730Z","steps":["trace[303880461] 'process raft request'  (duration: 148.248298ms)"],"step_count":1}
Jun 25 18:44:37.730675 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:44:37.730Z","caller":"traceutil/trace.go:171","msg":"trace[751726778] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"149.119502ms","start":"2024-06-25T18:44:37.581Z","end":"2024-06-25T18:44:37.730Z","steps":["trace[751726778] 'process raft request'  (duration: 148.940446ms)"],"step_count":1}
Jun 25 18:45:08.506650 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:08.506Z","caller":"traceutil/trace.go:171","msg":"trace[1140089765] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"131.340944ms","start":"2024-06-25T18:45:08.374Z","end":"2024-06-25T18:45:08.506Z","steps":["trace[1140089765] 'process raft request'  (duration: 68.605892ms)","trace[1140089765] 'compare'  (duration: 62.651694ms)"],"step_count":2}
Jun 25 18:45:15.213801 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:45:15.213Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"119.355436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7587879623507018664 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/default/nfs-server-provisioner\" mod_revision:614 > success:<request_put:<key:\"/registry/services/endpoints/default/nfs-server-provisioner\" value_size:1032 >> failure:<request_range:<key:\"/registry/services/endpoints/default/nfs-server-provisioner\" > >>","response":"size:16"}
Jun 25 18:45:15.214404 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:15.213Z","caller":"traceutil/trace.go:171","msg":"trace[817366893] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"219.42422ms","start":"2024-06-25T18:45:14.994Z","end":"2024-06-25T18:45:15.213Z","steps":["trace[817366893] 'process raft request'  (duration: 219.395215ms)"],"step_count":1}
Jun 25 18:45:15.214404 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:15.213Z","caller":"traceutil/trace.go:171","msg":"trace[1720543166] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"221.074688ms","start":"2024-06-25T18:45:14.992Z","end":"2024-06-25T18:45:15.213Z","steps":["trace[1720543166] 'process raft request'  (duration: 101.488794ms)","trace[1720543166] 'compare'  (duration: 119.248051ms)"],"step_count":2}
Jun 25 18:45:15.214404 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:15.213Z","caller":"traceutil/trace.go:171","msg":"trace[238359597] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"221.06536ms","start":"2024-06-25T18:45:14.992Z","end":"2024-06-25T18:45:15.213Z","steps":["trace[238359597] 'process raft request'  (duration: 220.899165ms)"],"step_count":1}
Jun 25 18:45:24.555748 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:24.555Z","caller":"traceutil/trace.go:171","msg":"trace[234228477] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"128.74829ms","start":"2024-06-25T18:45:24.426Z","end":"2024-06-25T18:45:24.555Z","steps":["trace[234228477] 'process raft request'  (duration: 47.662926ms)","trace[234228477] 'compare'  (duration: 80.985825ms)"],"step_count":2}
Jun 25 18:45:24.588529 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:24.588Z","caller":"traceutil/trace.go:171","msg":"trace[293269765] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:705; }","duration":"106.185532ms","start":"2024-06-25T18:45:24.481Z","end":"2024-06-25T18:45:24.588Z","steps":["trace[293269765] 'read index received'  (duration: 106.177717ms)","trace[293269765] 'applied index is now lower than readState.Index'  (duration: 6.763µs)"],"step_count":2}
Jun 25 18:45:24.588529 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:45:24.588Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.349652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-dynamic-volume-claim\" ","response":"range_response_count:1 size:1720"}
Jun 25 18:45:24.588794 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:24.588Z","caller":"traceutil/trace.go:171","msg":"trace[895998372] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-dynamic-volume-claim; range_end:; response_count:1; response_revision:679; }","duration":"106.463359ms","start":"2024-06-25T18:45:24.481Z","end":"2024-06-25T18:45:24.588Z","steps":["trace[895998372] 'agreement among raft nodes before linearized reading'  (duration: 106.294438ms)"],"step_count":1}
Jun 25 18:45:26.466955 update_engine[1375]: I0625 18:45:26.466878  1375 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs
Jun 25 18:45:26.466955 update_engine[1375]: I0625 18:45:26.466926  1375 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs
Jun 25 18:45:26.467435 update_engine[1375]: I0625 18:45:26.467108  1375 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs
Jun 25 18:45:26.467633 update_engine[1375]: I0625 18:45:26.467607  1375 omaha_request_params.cc:62] Current group set to alpha
Jun 25 18:45:26.467801 update_engine[1375]: I0625 18:45:26.467758  1375 update_attempter.cc:499] Already updated boot flags. Skipping.
Jun 25 18:45:26.467801 update_engine[1375]: I0625 18:45:26.467774  1375 update_attempter.cc:643] Scheduling an action processor start.
Jun 25 18:45:26.467801 update_engine[1375]: I0625 18:45:26.467788  1375 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
Jun 25 18:45:26.467997 update_engine[1375]: I0625 18:45:26.467828  1375 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs
Jun 25 18:45:26.467997 update_engine[1375]: I0625 18:45:26.467904  1375 omaha_request_action.cc:271] Posting an Omaha request to disabled
Jun 25 18:45:26.467997 update_engine[1375]: I0625 18:45:26.467912  1375 omaha_request_action.cc:272] Request: <?xml version="1.0" encoding="UTF-8"?>
Jun 25 18:45:26.467997 update_engine[1375]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
Jun 25 18:45:26.467997 update_engine[1375]:     <os version="Chateau" platform="CoreOS" sp="4012.0.0_x86_64"></os>
Jun 25 18:45:26.467997 update_engine[1375]:     <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="4012.0.0" track="alpha" bootid="{2c533530-b3b6-414c-a3af-472b7ff231c1}" oem="" oemversion="" alephversion="4012.0.0" machineid="6f50f9ae1ffb46618c48d0fd3ecf5079" machinealias="" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
Jun 25 18:45:26.467997 update_engine[1375]:         <ping active="1"></ping>
Jun 25 18:45:26.467997 update_engine[1375]:         <updatecheck></updatecheck>
Jun 25 18:45:26.467997 update_engine[1375]:         <event eventtype="3" eventresult="2" previousversion="0.0.0.0"></event>
Jun 25 18:45:26.467997 update_engine[1375]:     </app>
Jun 25 18:45:26.467997 update_engine[1375]: </request>
Jun 25 18:45:26.467997 update_engine[1375]: I0625 18:45:26.467917  1375 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
Jun 25 18:45:26.468234 locksmithd[1411]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0
Jun 25 18:45:26.469198 update_engine[1375]: I0625 18:45:26.469173  1375 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
Jun 25 18:45:26.469449 update_engine[1375]: I0625 18:45:26.469414  1375 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
Jun 25 18:45:26.485779 update_engine[1375]: E0625 18:45:26.485667  1375 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
Jun 25 18:45:26.485959 update_engine[1375]: I0625 18:45:26.485801  1375 libcurl_http_fetcher.cc:283] No HTTP response, retry 1
Jun 25 18:45:28.126307 etcd-wrapper[1628]: {"level":"warn","ts":"2024-06-25T18:45:28.125Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"109.568558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pod-1\" ","response":"range_response_count:1 size:3353"}
Jun 25 18:45:28.126307 etcd-wrapper[1628]: {"level":"info","ts":"2024-06-25T18:45:28.125Z","caller":"traceutil/trace.go:171","msg":"trace[492992980] range","detail":"{range_begin:/registry/pods/default/test-pod-1; range_end:; response_count:1; response_revision:688; }","duration":"109.663138ms","start":"2024-06-25T18:45:28.016Z","end":"2024-06-25T18:45:28.125Z","steps":["trace[492992980] 'range keys from in-memory index tree'  (duration: 109.456696ms)"],"step_count":1}