Step starting CRC with default bundle succeeds: command '$env:CRC_DISABLE_UPDATE_CHECK=true; crc start -p 'C:\Users\rhqp\crc-qe\pull-secret' ', expected to succeed, exited with exit code: 1
Command stdout: 
Command stderr: true : The term 'true' is not recognized as the name of a cmdlet, function, script file, or operable program. Check 
the spelling of the name, or if a path was included, verify that the path is correct and try again.
At line:1 char:31
+ $env:CRC_DISABLE_UPDATE_CHECK=true; crc start -p 'C:\Users\rhqp\crc-q ...
+                               ~~~~
    + CategoryInfo          : ObjectNotFound: (true:String) [], CommandNotFoundException
    + FullyQualifiedErrorId : CommandNotFoundException
 
level=debug msg="CRC version: 2.44.0+361dd8\n"
level=debug msg="OpenShift version: 4.17.3\n"
level=debug msg="MicroShift version: 4.17.3\n"
level=debug msg="Running 'crc start'"
level=debug msg="Total memory of system is 34358562816 bytes"
level=debug msg="No new version available. The latest version is 2.44.0"
level=debug msg="Checking file: C:\\Users\\rhqp\\.crc\\machines\\crc\\.crc-exist"
level=debug msg="Machine: libhvee -> state"
level=debug msg="Machine: libhvee -> get machine"
level=debug msg="Machine: libhvee -> state: get"
level=debug msg="Machine: libhvee -> state: stopped"
level=info msg="Using bundle path C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64.crcbundle"
level=info msg="Checking minimum RAM requirements"
level=debug msg="Total memory of system is 34358562816 bytes"
level=info msg="Check if Podman binary exists in: C:\\Users\\rhqp\\.crc\\bin\\oc"
level=info msg="Checking if running in a shell with administrator rights"
level=debug msg="Running '$currentPrincipal = New-Object Security.Principal.WindowsPrincipal([Security.Principal.WindowsIdentity]::GetCurrent());$currentPrincipal.IsInRole([Security.Principal.WindowsBuiltInRole]::Administrator)'"
level=info msg="Checking Windows release"
level=debug msg="Running '(Get-ItemProperty -Path \"HKLM:\\SOFTWARE\\Microsoft\\Windows NT\\CurrentVersion\" -Name ReleaseId).ReleaseId'"
level=info msg="Checking Windows edition"
level=debug msg="Running '(Get-ItemProperty -Path \"HKLM:\\SOFTWARE\\Microsoft\\Windows NT\\CurrentVersion\").EditionID'"
level=debug msg="Running on Windows Enterprise edition"
level=info msg="Checking if Hyper-V is installed and operational"
level=debug msg="Running '@(Get-Wmiobject Win32_ComputerSystem).HypervisorPresent'"
level=debug msg="Running '@(Get-Service vmms).Status'"
level=info msg="Checking if Hyper-V service is enabled"
level=debug msg="Running '@(Get-Service vmms).Status'"
level=info msg="Checking if crc-users group exists"
level=debug msg="Running 'Get-LocalGroup -Name crc-users'"
level=info msg="Checking if current user is in crc-users and Hyper-V admins group"
level=debug msg="Running '(Get-LocalGroupMember -Group 'crc-users').Name'"
level=debug msg="Checking current user is in the 'crc-user' group"
level=debug msg="group members: mapta56f96e4\\rhqp"
level=debug msg="Running '(Get-LocalGroupMember -SID 'S-1-5-32-578').Name'"
level=debug msg="Checking current user is in the 'Hyper-v Administrators' group"
level=debug msg="group members: mapta56f96e4\\rhqp"
level=info msg="Checking if vsock is correctly configured"
level=debug msg="Running 'Get-Item -Path \"HKLM:\\SOFTWARE\\Microsoft\\Windows NT\\CurrentVersion\\Virtualization\\GuestCommunicationServices\\00000400-FACB-11E6-BD58-64006A7986D3\"'"
level=info msg="Checking if the win32 background launcher is installed"
level=debug msg="Running '(Get-Item 'C:\\Program Files\\Red Hat OpenShift Local\\crc-background-launcher.exe').VersionInfo.FileVersion'"
level=debug msg="Found crc-background-launcher.exe version 0.0.0.1"
level=info msg="Checking if the daemon task is installed"
level=debug msg="Running 'Get-ScheduledTask -TaskName crcDaemon'"
level=debug msg="Running '(Get-ScheduledTask -TaskName \"crcDaemon\").Version'"
level=info msg="Checking if the daemon task is running"
level=debug msg="Running '(Get-ScheduledTask -TaskName \"crcDaemon\").State'"
level=info msg="Checking admin helper service is running"
level=debug msg="Running '(Get-Service crcAdminHelper).Status'"
level=info msg="Checking SSH port availability"
level=debug msg="Checking file: C:\\Users\\rhqp\\.crc\\machines\\crc\\.crc-exist"
level=debug msg="Copying 'C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\oc.exe' to 'C:\\Users\\rhqp\\.crc\\bin\\oc\\oc.exe'"
level=debug msg="Copying 'C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\podman.exe' to 'C:\\Users\\rhqp\\.crc\\bin\\podman\\podman.exe'"
level=info msg="Loading bundle: crc_hyperv_4.17.3_amd64..."
level=debug msg="Checking file: C:\\Users\\rhqp\\.crc\\machines\\crc\\.crc-exist"
level=debug msg="Machine: libhvee -> state"
level=debug msg="Machine: libhvee -> get machine"
level=debug msg="Machine: libhvee -> state: get"
level=debug msg="Machine: libhvee -> state: stopped"
level=debug msg="Copying 'C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\oc.exe' to 'C:\\Users\\rhqp\\.crc\\bin\\oc\\oc.exe'"
level=debug msg="Copying 'C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\podman.exe' to 'C:\\Users\\rhqp\\.crc\\bin\\podman\\podman.exe'"
level=info msg="Starting CRC VM for openshift 4.17.3..."
level=debug msg="Updating CRC VM configuration"
level=debug msg="Machine: libhvee -> get machine"
level=debug msg="Machine: libhvee -> start"
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="Machine: libhvee -> state"
level=debug msg="Machine: libhvee -> get machine"
level=debug msg="Machine: libhvee -> state: get"
level=debug msg="Machine: libhvee -> state: running"
level=debug msg="Machine is up and running!"
level=debug msg="Machine: libhvee -> state"
level=debug msg="Machine: libhvee -> get machine"
level=debug msg="Machine: libhvee -> state: get"
level=debug msg="Machine: libhvee -> state: running"
level=info msg="CRC instance is running with IP 127.0.0.1"
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: [C:\\Users\\rhqp\\.crc\\machines\\crc\\id_ed25519 C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\id_ecdsa_crc]"
level=debug msg="SSH command results: err: ssh: handshake failed: read tcp 127.0.0.1:53973->127.0.0.1:2222: wsarecv: An existing connection was forcibly closed by the remote host., output: "
level=debug msg="error: Temporary error: ssh command error:\ncommand : exit 0\nerr     : ssh: handshake failed: read tcp 127.0.0.1:53973->127.0.0.1:2222: wsarecv: An existing connection was forcibly closed by the remote host.\n - sleeping 1s"
level=debug msg="retry loop: attempt 1"
level=debug msg="Running SSH command: exit 0"
level=debug msg="Using ssh private keys: [C:\\Users\\rhqp\\.crc\\machines\\crc\\id_ed25519 C:\\Users\\rhqp\\.crc\\cache\\crc_hyperv_4.17.3_amd64\\id_ecdsa_crc]"
level=debug msg="SSH command results: err: <nil>, output: "
level=info msg="CRC VM is running"
level=debug msg="Using root access: disable core user password"
level=debug msg="Running SSH command: sudo passwd --lock core"
level=debug msg="SSH command results: err: <nil>, output: Locking password for user core.\npasswd: Success\n"
level=debug msg="Running SSH command: cat /home/core/.ssh/authorized_keys"
level=debug msg="SSH command results: err: Process exited with status 1, output: "
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: <nil>, output: "
level=debug msg="Using root access: Get device id"
level=debug msg="Running SSH command: sudo /usr/sbin/blkid -t TYPE=xfs -o device"
level=debug msg="SSH command results: err: <nil>, output: /dev/sda4\n"
level=debug msg="Using root access: Growing /dev/sda4 partition"
level=debug msg="Running SSH command: sudo /usr/bin/growpart /dev/sda 4"
level=debug msg="SSH command results: err: Process exited with status 1, output: NOCHANGE: partition 4 is size 82835423. it cannot be grown\n"
level=debug msg="No free space after /dev/sda4, nothing to do"
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="Running SSH command: systemctl status ovs-configuration.service"
level=debug msg="SSH command results: err: Process exited with status 3, output: ● ovs-configuration.service - Configures OVS with proper host networking configuration\n     Loaded: loaded (/etc/systemd/system/ovs-configuration.service; enabled; preset: disabled)\n     Active: activating (start) since Thu 2024-11-21 18:47:13 UTC; 612ms ago\n   Main PID: 1502 (configure-ovs.s)\n      Tasks: 2 (limit: 66264)\n     Memory: 61.1M\n        CPU: 326ms\n     CGroup: /system.slice/ovs-configuration.service\n             ├─1502 /bin/bash /usr/local/bin/configure-ovs.sh OVNKubernetes\n             ├─1508 /bin/bash /usr/local/bin/configure-ovs.sh OVNKubernetes\n             └─1782 ovs-vsctl --timeout=30 --if-exists del-br br-ex1\n\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:7314d5ea-a923-4db4-a200-eb141680aa17:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/1:no:::::/etc/NetworkManager/system-connections/internalEtcd-7314d5ea-a923-4db4-a200-eb141680aa17.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:d4b8cfdf-5bf1-40c9-b81c-19c54099e87d:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/2:no:::::/etc/NetworkManager/system-connections/internalEtcd-d4b8cfdf-5bf1-40c9-b81c-19c54099e87d.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:b9fff9af-82e2-4c7b-893f-c8336eeb5709:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/4:no:::::/etc/NetworkManager/system-connections/internalEtcd-b9fff9af-82e2-4c7b-893f-c8336eeb5709.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:8ef494a0-927f-4dc1-89f1-7f68a342bf4d:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/5:no:::::/etc/NetworkManager/system-connections/internalEtcd-8ef494a0-927f-4dc1-89f1-7f68a342bf4d.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:50a017c5-b743-4516-ba9b-7ef426a59a91:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/6:no:::::/etc/NetworkManager/system-connections/internalEtcd-50a017c5-b743-4516-ba9b-7ef426a59a91.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:16e9bb89-cea6-4c75-b8af-2944a4f3c7e5:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/7:no:::::/etc/NetworkManager/system-connections/internalEtcd-16e9bb89-cea6-4c75-b8af-2944a4f3c7e5.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1670]: internalEtcd:f1cc31c6-3f20-4de0-9880-085c8f2db226:dummy:0:never:yes:0:no:/org/freedesktop/NetworkManager/Settings/9:no:::::/etc/NetworkManager/system-connections/internalEtcd-f1cc31c6-3f20-4de0-9880-085c8f2db226.nmconnection\nNov 21 18:47:14 crc configure-ovs.sh[1508]: + ip -d address show\nNov 21 18:47:14 crc configure-ovs.sh[1676]: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000\nNov 21 18:47:14 crc configure-ovs.sh[1676]:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 promiscuity 0  allmulti 0 minmtu 0 maxmtu 0 numtxqueues 1 numrxqueues 1 gso_max_size 65536 gso_max_segs 65535 tso_max_size 524280 tso_max_segs 65535 gro_max_size 65536 gso_ipv4_max_size 65536 gro_ipv4_max_size 65536\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: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 1"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 2"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 3"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 4"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 5"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 6"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 7"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 8"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 9"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 10"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 11"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 12"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 13"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 14"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 15"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 16"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 17"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 18"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 19"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 20"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 21"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 22"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 23"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 24"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 25"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 26"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 27"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="retry loop: attempt 28"
level=debug msg="Running SSH command: host -R 3 foo.apps-crc.testing"
level=debug msg="SSH command results: err: Process exited with status 1, output: foo.apps-crc.testing has address 192.168.127.2\nHost foo.apps-crc.testing not found: 3(NXDOMAIN)\n"
level=debug msg="error: Temporary error: ssh command error:\ncommand : host -R 3 foo.apps-crc.testing\nerr     : Process exited with status 1\n - sleeping 1s"
level=debug msg="RetryAfter timeout after 29 tries"
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: Thu, 21 Nov 2024 18:48:01 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 [127.0.0.1]"
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: 2025-11-11T11:49:58+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: 2025-11-11T11:50:52+00:00\n"
level=debug msg="Running SSH command: date --date=\"$(sudo openssl x509 -in /etc/kubernetes/static-pod-resources/kube-apiserver-certs/secrets/aggregator-client/tls.crt -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
level=debug msg="SSH command results: err: <nil>, output: 2025-11-11T11:52:24+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 5s 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 5s 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 1"
level=debug msg="Running SSH command: timeout 5s 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    Ready    control-plane,master,worker   11d   v1.30.5\n"
level=debug msg="NAME   STATUS   ROLES                         AGE   VERSION\ncrc    Ready    control-plane,master,worker   11d   v1.30.5\n"
level=debug msg="Waiting for availability of resource type 'configmap'"
level=debug msg="retry loop: attempt 0"
level=debug msg="Running SSH command: timeout 5s oc get configmap --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 configmap machine-config-controller --context admin --cluster crc --kubeconfig /opt/kubeconfig"
level=debug msg="SSH command results: err: Process exited with status 1, output: "
level=debug msg="Waiting for availability of resource type 'lease'"
level=debug msg="retry loop: attempt 0"
level=debug msg="Running SSH command: timeout 5s oc get lease --context admin --cluster crc --kubeconfig /opt/kubeconfig"
level=debug msg="SSH command results: err: <nil>, output: "
level=debug
level=debug msg="Running SSH command: timeout 30s oc delete -A lease --all --context admin --cluster crc --kubeconfig /opt/kubeconfig"
level=debug msg="SSH command results: err: Process exited with status 124, output: lease.coordination.k8s.io \"crc\" deleted\nlease.coordination.k8s.io \"apiserver-yz2phfmetulqy4pemhbirhdnii\" deleted\nlease.coordination.k8s.io \"kube-controller-manager\" deleted\nlease.coordination.k8s.io \"openshift-apiserver-operator-lock\" deleted\nlease.coordination.k8s.io \"cluster-authentication-operator-lock\" deleted\nlease.coordination.k8s.io \"cluster-machine-approver-leader\" deleted\nlease.coordination.k8s.io \"version\" deleted\nlease.coordination.k8s.io \"config-operator-lock\" deleted\nlease.coordination.k8s.io \"console-operator-lock\" deleted\nlease.coordination.k8s.io \"openshift-controller-manager-operator-lock\" deleted\nlease.coordination.k8s.io \"openshift-master-controllers\" deleted\nlease.coordination.k8s.io \"openshift-cluster-etcd-operator-lock\" deleted\nlease.coordination.k8s.io \"openshift-master-controllers\" deleted\nlease.coordination.k8s.io \"kube-apiserver-operator-lock\" deleted\nlease.coordination.k8s.io \"cert-regeneration-controller-lock\" deleted\nlease.coordination.k8s.io \"kube-controller-manager-operator-lock\" deleted\nlease.coordination.k8s.io \"cert-recovery-controller-lock\" deleted\nlease.coordination.k8s.io \"cluster-policy-controller-lock\" deleted\nlease.coordination.k8s.io \"openshift-cluster-kube-scheduler-operator-lock\" deleted\nlease.coordination.k8s.io \"cert-recovery-controller-lock\" deleted\nlease.coordination.k8s.io \"kube-scheduler\" deleted\nlease.coordination.k8s.io \"openshift-kube-storage-version-migrator-operator-lock\" deleted\nlease.coordination.k8s.io \"control-plane-machine-set-leader\" deleted\nlease.coordination.k8s.io \"machine-api-operator\" deleted\nlease.coordination.k8s.io \"machine-config\" deleted\nlease.coordination.k8s.io \"machine-config-controller\" deleted\nlease.coordination.k8s.io \"marketplace-operator-lock\" deleted\nlease.coordination.k8s.io \"ovnkube-identity\" deleted\nlease.coordination.k8s.io \"network-operator-lock\" deleted\nlease.coordination.k8s.io \"packageserver-controller-lock\" deleted\nlease.coordination.k8s.io \"ovn-kubernetes-master\" deleted\nlease.coordination.k8s.io \"openshift-route-controllers\" deleted\nlease.coordination.k8s.io \"service-ca-operator-lock\" deleted\nlease.coordination.k8s.io \"service-ca-controller-lock\" deleted\n"
ssh command error:
command : timeout 30s oc delete -A lease --all --context admin --cluster crc --kubeconfig /opt/kubeconfig
err     : Process exited with status 124