Skip to content

Instantly share code, notes, and snippets.

@rajinder-yadav
Created April 24, 2022 18:27
Show Gist options
  • Save rajinder-yadav/4d10e43815c0e13d692bb7979afba8b1 to your computer and use it in GitHub Desktop.
Save rajinder-yadav/4d10e43815c0e13d692bb7979afba8b1 to your computer and use it in GitHub Desktop.
Error in driver during machine start: unexpected libvirt status 3 : machine in unknown state: getting ip during machine start
$ crc start --log-level debug
DEBU CodeReady Containers version: 2.0.1+bf3b1a6
DEBU OpenShift version: 4.10.3
DEBU Podman version: 3.4.4
DEBU Running 'crc start'
DEBU Total memory of system is 10314739712 bytes
DEBU No new version available. The latest version is 2.0.1
DEBU Checking file: /home/yadav/.crc/machines/crc/.crc-exist
DEBU Checking if systemd-resolved.service is running
DEBU Running 'systemctl status systemd-resolved.service'
DEBU Command failed: exit status 4
DEBU stdout:
DEBU stderr: Unit systemd-resolved.service could not be found.
INFO Checking if running as non-root
INFO Checking if running inside WSL2
INFO Checking if crc-admin-helper executable is cached
DEBU Running '/home/yadav/.crc/bin/crc-admin-helper-linux --version'
DEBU Found crc-admin-helper-linux version 0.0.10
DEBU crc-admin-helper executable already cached
INFO Checking for obsolete admin-helper executable
DEBU Checking if an older admin-helper executable is installed
DEBU No older admin-helper executable found
INFO Checking if running on a supported CPU architecture
INFO Checking minimum RAM requirements
DEBU Total memory of system is 10314739712 bytes
INFO Checking if crc executable symlink exists
INFO Checking if Virtualization is enabled
DEBU Checking if the vmx/svm flags are present in /proc/cpuinfo
DEBU CPU virtualization flags are good
INFO Checking if KVM is enabled
DEBU Checking if /dev/kvm exists
DEBU /dev/kvm was found
INFO Checking if libvirt is installed
DEBU Checking if 'virsh' is available
DEBU 'virsh' was found in /usr/bin/virsh
DEBU Checking 'virsh capabilities' for libvirtd/qemu availability
DEBU Running 'virsh --readonly --connect qemu:///system capabilities'
DEBU Found x86_64 hypervisor with 'hvm' capabilities
INFO Checking if user is part of libvirt group
DEBU Checking if current user is part of the libvirt group
DEBU Current user is already in the libvirt group
INFO Checking if active user/process is currently part of the libvirt group
INFO Checking if libvirt daemon is running
DEBU Checking if libvirtd service is running
DEBU Running 'systemctl status virtqemud.socket'
DEBU Command failed: exit status 4
DEBU stdout:
DEBU stderr: Unit virtqemud.socket could not be found.
DEBU virtqemud.socket is neither running nor listening
DEBU Running 'systemctl status libvirtd.socket'
DEBU Command failed: exit status 4
DEBU stdout:
DEBU stderr: Unit libvirtd.socket could not be found.
DEBU libvirtd.socket is neither running nor listening
DEBU Running 'systemctl status virtqemud.service'
DEBU Command failed: exit status 4
DEBU stdout:
DEBU stderr: Unit virtqemud.service could not be found.
DEBU virtqemud.service is neither running nor listening
DEBU Running 'systemctl status libvirtd.service'
DEBU libvirtd.service is running
INFO Checking if a supported libvirt version is installed
DEBU Checking if libvirt version is >=3.4.0
DEBU Running 'virsh -v'
INFO Checking if crc-driver-libvirt is installed
DEBU Checking if crc-driver-libvirt is installed
DEBU Running '/home/yadav/.crc/bin/crc-driver-libvirt version'
DEBU Found crc-driver-libvirt version 0.13.2
DEBU crc-driver-libvirt is already installed
INFO Checking if systemd-networkd is running
DEBU Checking if systemd-networkd.service is running
DEBU Running 'systemctl status systemd-networkd.service'
DEBU Command failed: exit status 4
DEBU stdout:
DEBU stderr: Unit systemd-networkd.service could not be found.
DEBU systemd-networkd.service is not running
INFO Checking if NetworkManager is installed
DEBU Checking if 'nmcli' is available
DEBU 'nmcli' was found in /usr/bin/nmcli
INFO Checking if NetworkManager service is running
DEBU Checking if NetworkManager.service is running
DEBU Running 'systemctl status NetworkManager.service'
DEBU NetworkManager.service is already running
INFO Checking if /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf exists
DEBU Checking NetworkManager configuration
DEBU NetworkManager configuration is good
INFO Checking if /etc/NetworkManager/dnsmasq.d/crc.conf exists
DEBU Checking dnsmasq configuration
DEBU dnsmasq configuration is good
INFO Checking if libvirt 'crc' network is available
DEBU Checking if libvirt 'crc' network exists
DEBU Running 'virsh --connect qemu:///system net-info crc'
DEBU Checking if libvirt 'crc' definition is up to date
DEBU Running 'virsh --connect qemu:///system net-dumpxml --inactive crc'
DEBU libvirt 'crc' network has the expected value
INFO Checking if libvirt 'crc' network is active
DEBU Checking if libvirt 'crc' network is active
DEBU Running 'virsh --connect qemu:///system net-info crc'
DEBU libvirt 'crc' network is already active
DEBU Checking file: /home/yadav/.crc/machines/crc/.crc-exist
INFO Loading bundle: crc_libvirt_4.10.3_amd64...
DEBU Cannot load secret from configuration: empty path
DEBU Cannot load secret from keyring: secret not found in keyring
CodeReady Containers requires a pull secret to download content from Red Hat.
You can copy it from the Pull Secret section of https://cloud.redhat.com/openshift/create/local.
? Please enter the pull secret ******************************************************************************************
INFO Creating CodeReady Containers VM for OpenShift 4.10.3...
DEBU Found binary path at /home/yadav/.crc/bin/crc-driver-libvirt
DEBU Launching plugin server for driver libvirt
DEBU Plugin server listening at address 127.0.0.1:45030
DEBU () Calling .GetVersion
DEBU Using API Version 1
DEBU () Calling .SetConfigRaw
DEBU () Calling .GetMachineName
DEBU (crc) Calling .GetMachineName
DEBU (crc) Calling .DriverName
DEBU Running pre-create checks...
DEBU (crc) Calling .PreCreateCheck
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="About to check libvirt version"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Validating network"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Validating storage pool"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Could not find storage pool 'crc', trying to create it"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Creating storage pool"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=info msg="Creating storage pool with XML <pool type=\"dir\">\n <name>crc</name>\n <target>\n <path>/home/yadav/.crc/machines/crc</path>\n </target>\n</pool>"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Activating pool 'crc'"
DEBU (crc) Calling .GetConfigRaw
DEBU Creating machine...
DEBU (crc) Calling .Create
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Preparing /home/yadav/.crc/machines/crc/crc.qcow2 for machine use"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="image creation took 27.934144ms"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Verifying executable bit set on /home/yadav/.crc/machines/crc"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Verifying executable bit set on /home/yadav/.crc/machines"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Verifying executable bit set on /home/yadav/.crc"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Verifying executable bit set on /home/yadav"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Verifying executable bit set on /home"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Defining VM..."
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Found x86_64 hypervisor with 'hvm' capabilities"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="No q35 machine type"
INFO Generating new SSH Key pair...
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="disk image capacity is already 33285996544 bytes"
INFO Generating new password for the kubeadmin user
DEBU Created /home/yadav/.crc/machines/crc/.crc-exist
DEBU Machine successfully created
DEBU Making call to close driver server
DEBU (crc) Calling .Close
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Closing plugin on server side"
DEBU Successfully made call to close driver server
DEBU Making call to close connection to plugin binary
DEBU Checking file: /home/yadav/.crc/machines/crc/.crc-exist
DEBU Found binary path at /home/yadav/.crc/bin/crc-driver-libvirt
DEBU Launching plugin server for driver libvirt
DEBU Plugin server listening at address 127.0.0.1:46049
DEBU () Calling .GetVersion
DEBU Using API Version 1
DEBU () Calling .SetConfigRaw
DEBU () Calling .GetMachineName
DEBU (crc) Calling .GetBundleName
DEBU (crc) Calling .GetState
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Getting current state..."
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Fetching VM..."
INFO Starting CodeReady Containers VM for OpenShift 4.10.3...
DEBU Updating CRC VM configuration
DEBU (crc) Calling .GetConfigRaw
DEBU (crc) Calling .Start
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Starting VM crc"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Validating network"
DEBU (crc) DBG | time="2022-04-24T14:25:19-04:00" level=debug msg="Validating storage pool"
DEBU (crc) DBG | time="2022-04-24T14:25:24-04:00" level=debug msg="GetIP called for crc"
DEBU (crc) DBG | time="2022-04-24T14:25:24-04:00" level=debug msg="Getting current state..."
DEBU (crc) DBG | time="2022-04-24T14:25:24-04:00" level=debug msg="Waiting for machine to come up 0/60"
DEBU (crc) DBG | time="2022-04-24T14:25:27-04:00" level=debug msg="GetIP called for crc"
DEBU (crc) DBG | time="2022-04-24T14:25:27-04:00" level=debug msg="Getting current state..."
DEBU (crc) DBG | time="2022-04-24T14:25:27-04:00" level=debug msg="Waiting for machine to come up 1/60"
DEBU (crc) DBG | time="2022-04-24T14:25:30-04:00" level=debug msg="GetIP called for crc"
DEBU (crc) DBG | time="2022-04-24T14:25:30-04:00" level=debug msg="Getting current state..."
DEBU (crc) DBG | time="2022-04-24T14:25:30-04:00" level=debug msg="Waiting for machine to come up 2/60"
DEBU (crc) DBG | time="2022-04-24T14:25:33-04:00" level=debug msg="GetIP called for crc"
DEBU (crc) DBG | time="2022-04-24T14:25:33-04:00" level=debug msg="Getting current state..."
DEBU Making call to close driver server
DEBU (crc) Calling .Close
DEBU Successfully made call to close driver server
DEBU Making call to close connection to plugin binary
Error starting machine: Error in driver during machine start: unexpected libvirt status 3 : machine in unknown state: getting ip during machine start
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment