Created
August 19, 2022 14:44
-
-
Save rwmjones/2c220e873879debbeb65fe4b864678d4 to your computer and use it in GitHub Desktop.
This file contains hidden or bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| level=debug msg="CRC version: 2.7.1+8b30b973\n" | |
| level=debug msg="OpenShift version: 4.11.0\n" | |
| level=debug msg="Podman version: 4.1.1\n" | |
| level=debug msg="Running 'crc start'" | |
| level=debug msg="Total memory of system is 16378507264 bytes" | |
| level=debug msg="No new version available. The latest version is 2.7.1" | |
| level=debug msg="Checking file: /home/rjones/.crc/machines/crc/.crc-exist" | |
| level=debug msg="Checking if systemd-resolved.service is running" | |
| level=debug msg="Running 'systemctl status systemd-resolved.service'" | |
| level=debug msg="systemd-resolved.service is already running" | |
| level=info msg="Checking if running as non-root" | |
| level=info msg="Checking if running inside WSL2" | |
| level=info msg="Checking if crc-admin-helper executable is cached" | |
| level=debug msg="Running '/home/rjones/.crc/bin/crc-admin-helper-linux --version'" | |
| level=debug msg="Found crc-admin-helper-linux version 0.0.11" | |
| level=debug msg="crc-admin-helper executable already cached" | |
| level=info msg="Checking for obsolete admin-helper executable" | |
| level=debug msg="Checking if an older admin-helper executable is installed" | |
| level=debug msg="No older admin-helper executable found" | |
| level=info msg="Checking if running on a supported CPU architecture" | |
| level=debug msg="GOARCH is amd64 GOOS is linux" | |
| level=info msg="Checking minimum RAM requirements" | |
| level=debug msg="Total memory of system is 16378507264 bytes" | |
| level=info msg="Checking if crc executable symlink exists" | |
| level=info msg="Checking if Virtualization is enabled" | |
| level=debug msg="Checking if the vmx/svm flags are present in /proc/cpuinfo" | |
| level=debug msg="CPU virtualization flags are good" | |
| level=info msg="Checking if KVM is enabled" | |
| level=debug msg="Checking if /dev/kvm exists" | |
| level=debug msg="/dev/kvm was found" | |
| level=info msg="Checking if libvirt is installed" | |
| level=debug msg="Checking if 'virsh' is available" | |
| level=debug msg="'virsh' was found in /usr/bin/virsh" | |
| level=debug msg="Checking 'virsh capabilities' for libvirtd/qemu availability" | |
| level=debug msg="Running 'virsh --readonly --connect qemu:///system capabilities'" | |
| level=debug msg="Found x86_64 hypervisor with 'hvm' capabilities" | |
| level=info msg="Checking if user is part of libvirt group" | |
| level=debug msg="Checking if current user is part of the libvirt group" | |
| level=debug msg="Current user is already in the libvirt group" | |
| level=info msg="Checking if active user/process is currently part of the libvirt group" | |
| level=info msg="Checking if libvirt daemon is running" | |
| level=debug msg="Checking if libvirtd service is running" | |
| level=debug msg="Running 'systemctl status virtqemud.socket'" | |
| level=debug msg="virtqemud.socket is running" | |
| level=info msg="Checking if a supported libvirt version is installed" | |
| level=debug msg="Checking if libvirt version is >=3.4.0" | |
| level=debug msg="Running 'virsh -v'" | |
| level=info msg="Checking if crc-driver-libvirt is installed" | |
| level=debug msg="Checking if crc-driver-libvirt is installed" | |
| level=debug msg="Running '/home/rjones/.crc/bin/crc-driver-libvirt version'" | |
| level=debug msg="Found crc-driver-libvirt version 0.13.5" | |
| level=debug msg="crc-driver-libvirt is already installed" | |
| level=info msg="Checking crc daemon systemd socket units" | |
| level=debug msg="Checking crc daemon systemd socket units" | |
| level=debug msg="Checking if crc-http.socket is running" | |
| level=debug msg="Running 'systemctl --user status crc-http.socket'" | |
| level=debug msg="crc-http.socket is listening" | |
| level=debug msg="Checking if crc-http.socket has the expected content" | |
| level=debug msg="Checking if crc-vsock.socket is running" | |
| level=debug msg="Running 'systemctl --user status crc-vsock.socket'" | |
| level=debug msg="crc-vsock.socket is listening" | |
| level=debug msg="Checking if crc-vsock.socket has the expected content" | |
| level=info msg="Checking if systemd-networkd is running" | |
| level=debug msg="Checking if systemd-networkd.service is running" | |
| level=debug msg="Running 'systemctl status systemd-networkd.service'" | |
| level=debug msg="Command failed: exit status 3" | |
| level=debug msg="stdout: * systemd-networkd.service - Network Configuration\n Loaded: loaded (/usr/lib/systemd/system/systemd-networkd.service; disabled; preset: disabled)\n Active: inactive (dead)\nTriggeredBy: * systemd-networkd.socket\n Docs: man:systemd-networkd.service(8)\n" | |
| level=debug msg="stderr: " | |
| level=debug msg="systemd-networkd.service is not running" | |
| level=info msg="Checking if NetworkManager is installed" | |
| level=debug msg="Checking if 'nmcli' is available" | |
| level=debug msg="'nmcli' was found in /usr/bin/nmcli" | |
| level=info msg="Checking if NetworkManager service is running" | |
| level=debug msg="Checking if NetworkManager.service is running" | |
| level=debug msg="Running 'systemctl status NetworkManager.service'" | |
| level=debug msg="NetworkManager.service is already running" | |
| level=info msg="Checking if dnsmasq configurations file exist for NetworkManager" | |
| level=info msg="Checking if the systemd-resolved service is running" | |
| level=debug msg="Checking if systemd-resolved.service is running" | |
| level=debug msg="Running 'systemctl status systemd-resolved.service'" | |
| level=debug msg="systemd-resolved.service is already running" | |
| level=info msg="Checking if /etc/NetworkManager/dispatcher.d/99-crc.sh exists" | |
| level=debug msg="Checking NetworkManager dispatcher file for crc network" | |
| level=debug msg="Dispatcher file has the expected content" | |
| level=info msg="Checking if libvirt 'crc' network is available" | |
| level=debug msg="Checking if libvirt 'crc' network exists" | |
| level=debug msg="Running 'virsh --connect qemu:///system net-info crc'" | |
| level=debug msg="Checking if libvirt 'crc' definition is up to date" | |
| level=debug msg="Running 'virsh --connect qemu:///system net-dumpxml --inactive crc'" | |
| level=debug msg="libvirt 'crc' network has the expected value" | |
| level=info msg="Checking if libvirt 'crc' network is active" | |
| level=debug msg="Checking if libvirt 'crc' network is active" | |
| level=debug msg="Running 'virsh --connect qemu:///system net-info crc'" | |
| level=debug msg="libvirt 'crc' network is already active" | |
| level=debug msg="Checking file: /home/rjones/.crc/machines/crc/.crc-exist" | |
| level=info msg="Loading bundle: crc_libvirt_4.11.0_amd64..." | |
| level=debug msg="Cannot load secret from configuration: empty path" | |
| level=debug msg="Cannot load secret from keyring: The name is not activatable" | |
| CRC requires a pull secret to download content from Red Hat. | |
| You can copy it from the Pull Secret section of https://console.redhat.com/openshift/create/local. | |
| [0;1;92m? [0m[0;1;99mPlease enter the pull secret [0m[?25l7[999;999f[6n8[?25h[6n**************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[0K[1A[0G[80C[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D[1D | |
| [1B[0Glevel=warning msg="Cannot add pull secret to keyring: The name is not activatable" | |
| level=info msg="Creating CRC VM for openshift 4.11.0..." | |
| level=debug msg="Found binary path at /home/rjones/.crc/bin/crc-driver-libvirt" | |
| level=debug msg="Launching plugin server for driver libvirt" | |
| level=debug msg="Plugin server listening at address 127.0.0.1:39265" | |
| level=debug msg="() Calling .GetVersion" | |
| level=debug msg="Using API Version 1" | |
| level=debug msg="() Calling .SetConfigRaw" | |
| level=debug msg="() Calling .GetMachineName" | |
| level=debug msg="(crc) Calling .GetMachineName" | |
| level=debug msg="(crc) Calling .DriverName" | |
| level=debug msg="Running pre-create checks..." | |
| level=debug msg="(crc) Calling .PreCreateCheck" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"About to check libvirt version\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Validating network\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Validating storage pool\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Could not find storage pool 'crc', trying to create it\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Creating storage pool\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=info msg=\"Creating storage pool with XML <pool type=\\\"dir\\\">\\n <name>crc</name>\\n <target>\\n <path>/home/rjones/.crc/machines/crc</path>\\n </target>\\n</pool>\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Activating pool 'crc'\"" | |
| level=debug msg="(crc) Calling .GetConfigRaw" | |
| level=debug msg="Creating machine..." | |
| level=debug msg="(crc) Calling .Create" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Preparing /home/rjones/.crc/machines/crc/crc.qcow2 for machine use\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"image creation took 212.801821ms\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Verifying executable bit set on /home/rjones/.crc/machines/crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Verifying executable bit set on /home/rjones/.crc/machines\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Verifying executable bit set on /home/rjones/.crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Verifying executable bit set on /home/rjones\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Verifying executable bit set on /home\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Defining VM...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Found x86_64 hypervisor with 'hvm' capabilities\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Found q35 machine type\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Found x86_64 hypervisor with 'hvm' capabilities\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Found q35 machine type\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"disk image capacity is already 33285996544 bytes\"" | |
| level=info msg="Generating new SSH key pair..." | |
| level=info msg="Generating new password for the kubeadmin user" | |
| level=debug msg="Created /home/rjones/.crc/machines/crc/.crc-exist" | |
| level=debug msg="Machine successfully created" | |
| level=debug msg="Making call to close driver server" | |
| level=debug msg="(crc) Calling .Close" | |
| level=debug msg="Successfully made call to close driver server" | |
| level=debug msg="Making call to close connection to plugin binary" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Closing plugin on server side\"" | |
| level=debug msg="Checking file: /home/rjones/.crc/machines/crc/.crc-exist" | |
| level=debug msg="Found binary path at /home/rjones/.crc/bin/crc-driver-libvirt" | |
| level=debug msg="Launching plugin server for driver libvirt" | |
| level=debug msg="Plugin server listening at address 127.0.0.1:46263" | |
| level=debug msg="() Calling .GetVersion" | |
| level=debug msg="Using API Version 1" | |
| level=debug msg="() Calling .SetConfigRaw" | |
| level=debug msg="() Calling .GetMachineName" | |
| level=debug msg="(crc) Calling .GetBundleName" | |
| level=debug msg="(crc) Calling .GetState" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:15+01:00\" level=debug msg=\"Fetching VM...\"" | |
| level=info msg="Starting CRC VM for openshift 4.11.0..." | |
| level=debug msg="Updating CRC VM configuration" | |
| level=debug msg="(crc) Calling .GetConfigRaw" | |
| level=debug msg="(crc) Calling .Start" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:16+01:00\" level=debug msg=\"Starting VM crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:16+01:00\" level=debug msg=\"Validating network\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:16+01:00\" level=debug msg=\"Validating storage pool\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:22+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:22+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:22+01:00\" level=debug msg=\"Waiting for machine to come up 0/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:25+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:25+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:25+01:00\" level=debug msg=\"Waiting for machine to come up 1/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:28+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:28+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:28+01:00\" level=debug msg=\"Waiting for machine to come up 2/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:31+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:31+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:31+01:00\" level=debug msg=\"Waiting for machine to come up 3/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:34+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:34+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:34+01:00\" level=debug msg=\"Waiting for machine to come up 4/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:37+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:37+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:37+01:00\" level=debug msg=\"Waiting for machine to come up 5/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:40+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:40+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:40+01:00\" level=debug msg=\"Waiting for machine to come up 6/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:43+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:43+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:43+01:00\" level=debug msg=\"Waiting for machine to come up 7/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:46+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:46+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:46+01:00\" level=debug msg=\"Waiting for machine to come up 8/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:49+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:49+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:49+01:00\" level=debug msg=\"Waiting for machine to come up 9/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:52+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:52+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:52+01:00\" level=debug msg=\"Waiting for machine to come up 10/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:55+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:55+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:55+01:00\" level=debug msg=\"Waiting for machine to come up 11/60\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"IP address: 192.168.130.11\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=info msg=\"Found IP for machine: 192.168.130.11\"" | |
| level=debug msg="(crc) Calling .GetConfigRaw" | |
| level=debug msg="Waiting for machine to be running, this may take a few minutes..." | |
| level=debug msg="retry loop: attempt 0" | |
| level=debug msg="(crc) Calling .GetState" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="Machine is up and running!" | |
| level=debug msg="(crc) Calling .GetState" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) Calling .GetIP" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"IP address: 192.168.130.11\"" | |
| level=info msg="CRC instance is running with IP 192.168.130.11" | |
| level=debug msg="(crc) Calling .GetIP" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"GetIP called for crc\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"Getting current state...\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:34:58+01:00\" level=debug msg=\"IP address: 192.168.130.11\"" | |
| level=debug msg="Waiting until ssh is available" | |
| level=debug msg="retry loop: attempt 0" | |
| level=debug msg="Running SSH command: exit 0" | |
| level=debug msg="Using ssh private keys: [/home/rjones/.crc/machines/crc/id_ecdsa /home/rjones/.crc/cache/crc_libvirt_4.11.0_amd64/id_ecdsa_crc]" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=info msg="CRC VM is running" | |
| level=debug msg="Running SSH command: cat /home/core/.ssh/authorized_keys" | |
| level=debug msg="SSH command results: err: <nil>, output: ecdsa-sha2-nistp521 AAAAE2VjZHNhLXNoYTItbmlzdHA1MjEAAAAIbmlzdHA1MjEAAACFBAAdrp6u8Ogq3sucd8H2TUMA3Nhrh0Emvsm173O7OaAAvWg7D3O6U9kKhwK87HjXMVdXmvcTNZJGpgwikC5b9za0DwGzw+BLra6wT8R+NdNcL1g0la4CJJ7dfnHKitScVliiO06bvohkw59fBISwXW0OYJPmyGLwqXZjzjfFJiohiavzZA== core\n" | |
| level=info msg="Updating authorized keys..." | |
| level=debug msg="Creating /home/core/.ssh/authorized_keys with permissions 0644 in the CRC VM" | |
| level=debug msg="Running SSH command: <hidden>" | |
| level=debug msg="SSH command succeeded" | |
| level=debug msg="Running SSH command: rm /home/core/.ssh/authorized_keys.d/ignition" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="Running SSH command: realpath /dev/disk/by-label/root" | |
| level=debug msg="SSH command results: err: <nil>, output: /dev/vda4\n" | |
| level=debug msg="Using root access: Growing /dev/vda4 partition" | |
| level=debug msg="Running SSH command: sudo /usr/bin/growpart /dev/vda 4" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: NOCHANGE: partition 4 is size 63961055. it cannot be grown\n" | |
| level=debug msg="No free space after /dev/vda4, nothing to do" | |
| level=debug msg="Configuring shared directories" | |
| level=debug msg="(crc) Calling .GetSharedDirs" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:35:00+01:00\" level=debug msg=\"Found x86_64 hypervisor with 'hvm' capabilities\"" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:35:00+01:00\" level=debug msg=\"Found q35 machine type\"" | |
| level=info msg="Configuring shared directories" | |
| level=debug msg="Using root access: Creating /home/rjones" | |
| level=debug msg="Running SSH command: sudo mkdir -p /home/rjones" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Mounting tag dir0 at /home/rjones" | |
| level=debug msg="Using root access: Mounting /home/rjones" | |
| level=debug msg="Running SSH command: sudo mount -o context=\"system_u:object_r:container_file_t:s0\" -t virtiofs dir0 /home/rjones" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Using root access: make root Podman socket accessible" | |
| level=debug msg="Running SSH command: sudo chmod 777 /run/podman/ /run/podman/podman.sock" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Creating /var/srv/dnsmasq.conf with permissions 0644 in the CRC VM" | |
| level=debug msg="Running SSH command: <hidden>" | |
| level=debug msg="SSH command succeeded" | |
| level=debug msg="Running SSH command: systemctl status crc-dnsmasq.service" | |
| level=debug msg="SSH command results: err: Process exited with status 3, output: ● crc-dnsmasq.service - Podman container-afd58aa85e12b450531c909d9c941e4381365fa303d41f696469ca5ebbc75f3f.service\n Loaded: loaded (/etc/systemd/system/crc-dnsmasq.service; disabled; vendor preset: disabled)\n Active: inactive (dead)\n Docs: man:podman-generate-systemd(1)\n" | |
| level=debug msg="Using root access: Executing systemctl enable crc-dnsmasq.service" | |
| level=debug msg="Running SSH command: sudo systemctl enable crc-dnsmasq.service" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Using root access: Executing systemctl daemon-reload command" | |
| level=debug msg="Running SSH command: sudo systemctl daemon-reload" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Using root access: Executing systemctl start crc-dnsmasq.service" | |
| level=debug msg="Running SSH command: sudo systemctl start crc-dnsmasq.service" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Running '/home/rjones/.crc/bin/crc-admin-helper-linux rm api.crc.testing oauth-openshift.apps-crc.testing console-openshift-console.apps-crc.testing downloads-openshift-console.apps-crc.testing canary-openshift-ingress-canary.apps-crc.testing default-route-openshift-image-registry.apps-crc.testing'" | |
| level=debug msg="Running '/home/rjones/.crc/bin/crc-admin-helper-linux add 192.168.130.11 api.crc.testing oauth-openshift.apps-crc.testing console-openshift-console.apps-crc.testing downloads-openshift-console.apps-crc.testing canary-openshift-ingress-canary.apps-crc.testing default-route-openshift-image-registry.apps-crc.testing'" | |
| level=debug msg="Running SSH command: cat /etc/resolv.conf" | |
| level=debug msg="SSH command results: err: <nil>, output: # Generated by NetworkManager\nnameserver 192.168.130.1\n" | |
| level=debug msg="Creating /etc/resolv.conf with permissions 0644 in the CRC VM" | |
| level=debug msg="Running SSH command: <hidden>" | |
| level=debug msg="SSH command succeeded" | |
| level=debug msg="retry loop: attempt 0" | |
| level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing" | |
| level=debug msg="SSH command results: err: <nil>, output: foo.apps-crc.testing has address 192.168.130.11\n" | |
| level=info msg="Check internal and public DNS query..." | |
| level=debug msg="Running SSH command: curl --head quay.io" | |
| level=debug msg="SSH command results: err: <nil>, output: HTTP/1.1 301 Moved Permanently\r\nServer: awselb/2.0\r\nDate: Fri, 19 Aug 2022 14:35:17 GMT\r\nContent-Type: text/html\r\nContent-Length: 134\r\nConnection: keep-alive\r\nLocation: https://quay.io:443/\r\n\r\n" | |
| level=info msg="Check DNS query from host..." | |
| level=debug msg="api.crc.testing resolved to [192.168.130.11]" | |
| level=debug msg="foo.apps-crc.testing resolved to [192.168.130.11]" | |
| level=info msg="Verifying validity of the kubelet certificates..." | |
| level=debug msg="Running SSH command: date --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds" | |
| level=debug msg="SSH command results: err: <nil>, output: 2022-09-08T06:27:59+00:00\n" | |
| level=debug msg="Running SSH command: date --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds" | |
| level=debug msg="SSH command results: err: <nil>, output: 2022-09-08T06:31:57+00:00\n" | |
| level=debug msg="Running SSH command: date --date=\"$(sudo openssl x509 -in /etc/kubernetes/static-pod-resources/kube-apiserver-certs/configmaps/aggregator-client-ca/ca-bundle.crt -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds" | |
| level=debug msg="SSH command results: err: <nil>, output: 2022-09-08T06:33:01+00:00\n" | |
| level=info msg="Starting kubelet service" | |
| level=debug msg="Using root access: Executing systemctl daemon-reload command" | |
| level=debug msg="Running SSH command: sudo systemctl daemon-reload" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=debug msg="Using root access: Executing systemctl start kubelet" | |
| level=debug msg="Running SSH command: sudo systemctl start kubelet" | |
| level=debug msg="SSH command results: err: <nil>, output: " | |
| level=info msg="Waiting for kube-apiserver availability... [takes around 2min]" | |
| level=debug msg="retry loop: attempt 0" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 1" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 2" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 3" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 4" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 5" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 6" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 7" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 8" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 9" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 10" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 11" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 12" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 13" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 14" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 15" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 16" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 17" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 18" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 19" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 20" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 21" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 22" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 23" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 24" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 25" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 1, output: " | |
| level=debug msg="The connection to the server api.crc.testing:6443 was refused - did you specify the right host or port?\n" | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 26" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 124, output: " | |
| level=debug | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 124\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 27" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 124, output: " | |
| level=debug | |
| level=debug msg="error: Temporary error: ssh command error:\ncommand : timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 124\n - sleeping 1s" | |
| level=debug msg="retry loop: attempt 28" | |
| level=debug msg="Running SSH command: timeout 30s oc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: <nil>, output: NAME STATUS ROLES AGE VERSION\ncrc-9jm8r-master-0 Ready master,worker 11d v1.24.0+9546431\n" | |
| level=debug msg="NAME STATUS ROLES AGE VERSION\ncrc-9jm8r-master-0 Ready master,worker 11d v1.24.0+9546431\n" | |
| level=debug msg="Waiting for availability of resource type 'cm'" | |
| level=debug msg="retry loop: attempt 0" | |
| level=debug msg="Running SSH command: timeout 30s oc get cm --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: <nil>, output: NAME DATA AGE\nkube-root-ca.crt 1 11d\nopenshift-service-ca.crt 1 11d\n" | |
| level=debug msg="NAME DATA AGE\nkube-root-ca.crt 1 11d\nopenshift-service-ca.crt 1 11d\n" | |
| level=debug msg="Running SSH command: timeout 30s oc delete -n openshift-machine-config-operator cm machine-config-controller --context admin --cluster crc --kubeconfig /opt/kubeconfig" | |
| level=debug msg="SSH command results: err: Process exited with status 124, output: " | |
| level=debug msg="Making call to close driver server" | |
| level=debug msg="(crc) Calling .Close" | |
| level=debug msg="Successfully made call to close driver server" | |
| level=debug msg="(crc) DBG | time=\"2022-08-19T15:38:48+01:00\" level=debug msg=\"Closing plugin on server side\"" | |
| level=debug msg="Making call to close connection to plugin binary" | |
| ssh command error: | |
| command : timeout 30s oc delete -n openshift-machine-config-operator cm machine-config-controller --context admin --cluster crc --kubeconfig /opt/kubeconfig | |
| err : Process exited with status 124 |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment