Skip to content

Instantly share code, notes, and snippets.

@danielmenezesbr
Created June 28, 2021 18:24
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save danielmenezesbr/6cc2e5de93e11f2d2e8dfd55415e4c64 to your computer and use it in GitHub Desktop.
Save danielmenezesbr/6cc2e5de93e11f2d2e8dfd55415e4c64 to your computer and use it in GitHub Desktop.
CRC 1.22
time="2021-06-28T17:46:50Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:46:50Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:46:50Z" level=debug msg="Running 'crc setup'"
time="2021-06-28T17:46:50Z" level=info msg="Checking if running as non-root"
time="2021-06-28T17:46:50Z" level=info msg="Checking if podman remote executable is cached"
time="2021-06-28T17:46:50Z" level=debug msg="Currently podman remote is not supported"
time="2021-06-28T17:46:50Z" level=info msg="Checking if admin-helper executable is cached"
time="2021-06-28T17:46:50Z" level=debug msg="admin-helper executable is not cached"
time="2021-06-28T17:46:50Z" level=info msg="Caching admin-helper executable"
time="2021-06-28T17:46:50Z" level=debug msg="Trying to extract admin-helper-linux from crc executable"
time="2021-06-28T17:46:50Z" level=debug msg="Extracting embedded 'admin-helper-linux' from /home/crcuser/crc/crc to /tmp/crc970877358/admin-helper-linux"
time="2021-06-28T17:46:50Z" level=debug msg="Copying '/tmp/crc970877358/admin-helper-linux' to '/home/crcuser/.crc/bin/admin-helper-linux'"
time="2021-06-28T17:46:50Z" level=debug msg="admin-helper executable cached"
time="2021-06-28T17:46:50Z" level=debug msg="Making /home/crcuser/.crc/bin/admin-helper-linux suid"
time="2021-06-28T17:46:50Z" level=info msg="Using root access: Changing ownership of /home/crcuser/.crc/bin/admin-helper-linux"
time="2021-06-28T17:46:50Z" level=debug msg="Running '/usr/bin/sudo chown root /home/crcuser/.crc/bin/admin-helper-linux'"
time="2021-06-28T17:46:50Z" level=info msg="Using root access: Setting suid for /home/crcuser/.crc/bin/admin-helper-linux"
time="2021-06-28T17:46:50Z" level=debug msg="Running '/usr/bin/sudo chmod u+s,g+x /home/crcuser/.crc/bin/admin-helper-linux'"
time="2021-06-28T17:46:50Z" level=info msg="Checking if CRC bundle is extracted in '$HOME/.crc'"
time="2021-06-28T17:46:50Z" level=info msg="Checking if /home/crcuser/.crc/cache/crc_libvirt_4.6.15.crcbundle exists"
time="2021-06-28T17:46:50Z" level=debug msg="error getting bundle info for crc_libvirt_4.6.15.crcbundle: could not find cached bundle info in /home/crcuser/.crc/cache/crc_libvirt_4.6.15: stat /home/crcuser/.crc/cache/crc_libvirt_4.6.15: no such file or directory"
time="2021-06-28T17:46:50Z" level=debug msg="could not find cached bundle info in /home/crcuser/.crc/cache/crc_libvirt_4.6.15: stat /home/crcuser/.crc/cache/crc_libvirt_4.6.15: no such file or directory"
time="2021-06-28T17:46:50Z" level=info msg="Extracting bundle from the CRC executable"
time="2021-06-28T17:46:50Z" level=debug msg="Error changing /home/crcuser/.crc/cache permissions to 0775"
time="2021-06-28T17:46:50Z" level=info msg="Ensuring directory /home/crcuser/.crc/cache exists"
time="2021-06-28T17:46:50Z" level=info msg="Extracting embedded bundle crc_libvirt_4.6.15.crcbundle to /home/crcuser/.crc/cache"
time="2021-06-28T17:46:50Z" level=debug msg="Extracting embedded 'crc_libvirt_4.6.15.crcbundle' from /home/crcuser/crc/crc to /home/crcuser/.crc/cache/crc_libvirt_4.6.15.crcbundle"
time="2021-06-28T17:46:51Z" level=info msg="Uncompressing crc_libvirt_4.6.15.crcbundle"
time="2021-06-28T17:46:51Z" level=debug msg="Uncompressing /home/crcuser/.crc/cache/crc_libvirt_4.6.15.crcbundle to /home/crcuser/.crc/cache/tmp-extract"
time="2021-06-28T17:50:21Z" level=info msg="Checking minimum RAM requirements"
time="2021-06-28T17:50:21Z" level=debug msg="Total memory of system is 31396773888 bytes"
time="2021-06-28T17:50:21Z" level=info msg="Checking if Virtualization is enabled"
time="2021-06-28T17:50:21Z" level=debug msg="Checking if the vmx/svm flags are present in /proc/cpuinfo"
time="2021-06-28T17:50:21Z" level=debug msg="CPU virtualization flags are good"
time="2021-06-28T17:50:21Z" level=info msg="Checking if KVM is enabled"
time="2021-06-28T17:50:21Z" level=debug msg="Checking if /dev/kvm exists"
time="2021-06-28T17:50:21Z" level=debug msg="/dev/kvm was found"
time="2021-06-28T17:50:21Z" level=info msg="Checking if libvirt is installed"
time="2021-06-28T17:50:21Z" level=debug msg="Checking if 'virsh' is available"
time="2021-06-28T17:50:21Z" level=debug msg="Libvirt cli virsh was not found in path"
time="2021-06-28T17:50:21Z" level=info msg="Installing libvirt service and dependencies"
time="2021-06-28T17:50:21Z" level=debug msg="Trying to install libvirt"
time="2021-06-28T17:50:21Z" level=info msg="Using root access: Installing virtualization packages"
time="2021-06-28T17:50:21Z" level=debug msg="Running '/usr/bin/sudo /bin/sh -c yum install -y libvirt libvirt-daemon-kvm qemu-kvm'"
time="2021-06-28T17:51:06Z" level=debug msg="libvirt was successfully installed"
time="2021-06-28T17:51:06Z" level=info msg="Checking if user is part of libvirt group"
time="2021-06-28T17:51:06Z" level=debug msg="Checking if current user is part of the libvirt group"
time="2021-06-28T17:51:06Z" level=debug msg="Current user is already in the libvirt group"
time="2021-06-28T17:51:06Z" level=info msg="Checking if libvirt daemon is running"
time="2021-06-28T17:51:06Z" level=debug msg="Checking if libvirtd service is running"
time="2021-06-28T17:51:06Z" level=debug msg="Running 'systemctl status virtqemud.socket'"
time="2021-06-28T17:51:06Z" level=debug msg="Command failed: exit status 3"
time="2021-06-28T17:51:06Z" level=debug msg="stdout: * virtqemud.socket - Libvirt qemu local socket\n Loaded: loaded (/usr/lib/systemd/system/virtqemud.socket; disabled; vendor preset: disabled)\n Active: inactive (dead)\n Listen: /run/libvirt/virtqemud-sock (Stream)\n"
time="2021-06-28T17:51:06Z" level=debug msg="stderr: "
time="2021-06-28T17:51:06Z" level=debug msg="virtqemud.socket is neither running nor listening"
time="2021-06-28T17:51:06Z" level=debug msg="Running 'systemctl status libvirtd.socket'"
time="2021-06-28T17:51:06Z" level=debug msg="Command failed: exit status 3"
time="2021-06-28T17:51:06Z" level=debug msg="stdout: * libvirtd.socket - Libvirt local socket\n Loaded: loaded (/usr/lib/systemd/system/libvirtd.socket; enabled; vendor preset: disabled)\n Active: inactive (dead)\n Listen: /run/libvirt/libvirt-sock (Stream)\n"
time="2021-06-28T17:51:06Z" level=debug msg="stderr: "
time="2021-06-28T17:51:06Z" level=debug msg="libvirtd.socket is neither running nor listening"
time="2021-06-28T17:51:06Z" level=debug msg="Running 'systemctl status virtqemud.service'"
time="2021-06-28T17:51:06Z" level=debug msg="Command failed: exit status 3"
time="2021-06-28T17:51:06Z" level=debug msg="stdout: * virtqemud.service - Virtualization qemu daemon\n Loaded: loaded (/usr/lib/systemd/system/virtqemud.service; disabled; vendor preset: disabled)\n Active: inactive (dead)\n Docs: man:libvirtd(8)\n https://libvirt.org\n"
time="2021-06-28T17:51:06Z" level=debug msg="stderr: "
time="2021-06-28T17:51:06Z" level=debug msg="virtqemud.service is neither running nor listening"
time="2021-06-28T17:51:06Z" level=debug msg="Running 'systemctl status libvirtd.service'"
time="2021-06-28T17:51:06Z" level=debug msg="Command failed: exit status 3"
time="2021-06-28T17:51:06Z" level=debug msg="stdout: * libvirtd.service - Virtualization daemon\n Loaded: loaded (/usr/lib/systemd/system/libvirtd.service; enabled; vendor preset: enabled)\n Active: inactive (dead)\n Docs: man:libvirtd(8)\n https://libvirt.org\n"
time="2021-06-28T17:51:06Z" level=debug msg="stderr: "
time="2021-06-28T17:51:06Z" level=debug msg="libvirtd.service is neither running nor listening"
time="2021-06-28T17:51:06Z" level=warning msg="No active (running) libvirtd systemd unit could be found - make sure one of libvirt systemd units is enabled so that it's autostarted at boot time."
time="2021-06-28T17:51:06Z" level=debug msg="found no active libvirtd systemd unit"
time="2021-06-28T17:51:06Z" level=info msg="Starting libvirt service"
time="2021-06-28T17:51:06Z" level=debug msg="Starting libvirtd.service"
time="2021-06-28T17:51:06Z" level=info msg="Using root access: Executing systemctl daemon-reload command"
time="2021-06-28T17:51:06Z" level=debug msg="Running '/usr/bin/sudo systemctl daemon-reload'"
time="2021-06-28T17:51:06Z" level=info msg="Using root access: Executing systemctl start libvirtd"
time="2021-06-28T17:51:06Z" level=debug msg="Running '/usr/bin/sudo systemctl start libvirtd'"
time="2021-06-28T17:51:07Z" level=debug msg="libvirtd.service is running"
time="2021-06-28T17:51:07Z" level=info msg="Checking if a supported libvirt version is installed"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if libvirt version is >=3.4.0"
time="2021-06-28T17:51:07Z" level=debug msg="Running 'virsh -v'"
time="2021-06-28T17:51:07Z" level=info msg="Checking if crc-driver-libvirt is installed"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if crc-driver-libvirt is installed"
time="2021-06-28T17:51:07Z" level=debug msg="crc-driver-libvirt executable is not cached"
time="2021-06-28T17:51:07Z" level=info msg="Installing crc-driver-libvirt"
time="2021-06-28T17:51:07Z" level=debug msg="Installing crc-driver-libvirt"
time="2021-06-28T17:51:07Z" level=debug msg="Trying to extract crc-driver-libvirt from crc executable"
time="2021-06-28T17:51:07Z" level=debug msg="Extracting embedded 'crc-driver-libvirt' from /home/crcuser/crc/crc to /tmp/crc483632437/crc-driver-libvirt"
time="2021-06-28T17:51:07Z" level=debug msg="Copying '/tmp/crc483632437/crc-driver-libvirt' to '/home/crcuser/.crc/bin/crc-driver-libvirt'"
time="2021-06-28T17:51:07Z" level=debug msg="crc-driver-libvirt is installed in /home/crcuser/.crc/bin"
time="2021-06-28T17:51:07Z" level=info msg="Checking if systemd-networkd is running"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if systemd-networkd.service is running"
time="2021-06-28T17:51:07Z" level=debug msg="Running 'systemctl status systemd-networkd.service'"
time="2021-06-28T17:51:07Z" level=debug msg="Command failed: exit status 4"
time="2021-06-28T17:51:07Z" level=debug msg="stdout: "
time="2021-06-28T17:51:07Z" level=debug msg="stderr: Unit systemd-networkd.service could not be found.\n"
time="2021-06-28T17:51:07Z" level=debug msg="systemd-networkd.service is not running"
time="2021-06-28T17:51:07Z" level=info msg="Checking if NetworkManager is installed"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if 'nmcli' is available"
time="2021-06-28T17:51:07Z" level=debug msg="'nmcli' was found in /usr/bin/nmcli"
time="2021-06-28T17:51:07Z" level=info msg="Checking if NetworkManager service is running"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if NetworkManager.service is running"
time="2021-06-28T17:51:07Z" level=debug msg="Running 'systemctl status NetworkManager.service'"
time="2021-06-28T17:51:07Z" level=debug msg="NetworkManager.service is already running"
time="2021-06-28T17:51:07Z" level=info msg="Checking if /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf exists"
time="2021-06-28T17:51:07Z" level=debug msg="Checking NetworkManager configuration"
time="2021-06-28T17:51:07Z" level=debug msg="File not found: /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf: stat /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf: no such file or directory"
time="2021-06-28T17:51:07Z" level=info msg="Writing Network Manager config for crc"
time="2021-06-28T17:51:07Z" level=debug msg="Fixing NetworkManager configuration"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Writing NetworkManager configuration to /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Changing permissions for /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf to 644 "
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo chmod 644 /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf'"
time="2021-06-28T17:51:07Z" level=debug msg="Reloading NetworkManager"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Executing systemctl daemon-reload command"
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo systemctl daemon-reload'"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Executing systemctl reload NetworkManager"
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo systemctl reload NetworkManager'"
time="2021-06-28T17:51:07Z" level=debug msg="NetworkManager configuration fixed"
time="2021-06-28T17:51:07Z" level=info msg="Checking if /etc/NetworkManager/dnsmasq.d/crc.conf exists"
time="2021-06-28T17:51:07Z" level=debug msg="Checking dnsmasq configuration"
time="2021-06-28T17:51:07Z" level=debug msg="File not found: /etc/NetworkManager/dnsmasq.d/crc.conf: stat /etc/NetworkManager/dnsmasq.d/crc.conf: no such file or directory"
time="2021-06-28T17:51:07Z" level=info msg="Writing dnsmasq config for crc"
time="2021-06-28T17:51:07Z" level=debug msg="Fixing dnsmasq configuration"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Writing NetworkManager configuration to /etc/NetworkManager/dnsmasq.d/crc.conf"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Changing permissions for /etc/NetworkManager/dnsmasq.d/crc.conf to 644 "
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo chmod 644 /etc/NetworkManager/dnsmasq.d/crc.conf'"
time="2021-06-28T17:51:07Z" level=debug msg="Reloading NetworkManager"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Executing systemctl daemon-reload command"
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo systemctl daemon-reload'"
time="2021-06-28T17:51:07Z" level=info msg="Using root access: Executing systemctl reload NetworkManager"
time="2021-06-28T17:51:07Z" level=debug msg="Running '/usr/bin/sudo systemctl reload NetworkManager'"
time="2021-06-28T17:51:07Z" level=debug msg="dnsmasq configuration fixed"
time="2021-06-28T17:51:07Z" level=info msg="Checking if libvirt 'crc' network is available"
time="2021-06-28T17:51:07Z" level=debug msg="Checking if libvirt 'crc' network exists"
time="2021-06-28T17:51:07Z" level=debug msg="Running 'virsh --connect qemu:///system net-info crc'"
time="2021-06-28T17:51:08Z" level=debug msg="Command failed: exit status 1"
time="2021-06-28T17:51:08Z" level=debug msg="stdout: \n"
time="2021-06-28T17:51:08Z" level=debug msg="stderr: error: failed to get network 'crc'\nerror: Network not found: no network with matching name 'crc'\n"
time="2021-06-28T17:51:08Z" level=debug msg="Libvirt network crc not found"
time="2021-06-28T17:51:08Z" level=info msg="Setting up libvirt 'crc' network"
time="2021-06-28T17:51:08Z" level=debug msg="Creating libvirt 'crc' network"
time="2021-06-28T17:51:08Z" level=debug msg="Running 'virsh --connect qemu:///system net-destroy crc'"
time="2021-06-28T17:51:08Z" level=debug msg="Command failed: exit status 1"
time="2021-06-28T17:51:08Z" level=debug msg="stdout: \n"
time="2021-06-28T17:51:08Z" level=debug msg="stderr: error: failed to get network 'crc'\nerror: Network not found: no network with matching name 'crc'\n"
time="2021-06-28T17:51:08Z" level=debug msg="Running 'virsh --connect qemu:///system net-undefine crc'"
time="2021-06-28T17:51:08Z" level=debug msg="Command failed: exit status 1"
time="2021-06-28T17:51:08Z" level=debug msg="stdout: \n"
time="2021-06-28T17:51:08Z" level=debug msg="stderr: error: failed to get network 'crc'\nerror: Network not found: no network with matching name 'crc'\n"
time="2021-06-28T17:51:08Z" level=debug msg="libvirt 'crc' network created"
time="2021-06-28T17:51:08Z" level=info msg="Checking if libvirt 'crc' network is active"
time="2021-06-28T17:51:08Z" level=debug msg="Checking if libvirt 'crc' network is active"
time="2021-06-28T17:51:08Z" level=debug msg="Running 'virsh --connect qemu:///system net-info crc'"
time="2021-06-28T17:51:08Z" level=debug msg="Libvirt crc network is not active"
time="2021-06-28T17:51:08Z" level=info msg="Starting libvirt 'crc' network"
time="2021-06-28T17:51:08Z" level=debug msg="Starting libvirt 'crc' network"
time="2021-06-28T17:51:08Z" level=debug msg="Running 'virsh --connect qemu:///system net-start crc'"
time="2021-06-28T17:51:08Z" level=debug msg="Running 'virsh --connect qemu:///system net-autostart crc'"
time="2021-06-28T17:51:08Z" level=debug msg="libvirt 'crc' network started"
time="2021-06-28T17:51:09Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:51:09Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:51:09Z" level=debug msg="Running 'crc config set'"
time="2021-06-28T17:51:09Z" level=debug msg="Total memory of system is 31396773888 bytes"
time="2021-06-28T17:51:09Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:51:09Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:51:09Z" level=debug msg="Running 'crc config set'"
time="2021-06-28T17:51:09Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:51:09Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:51:09Z" level=debug msg="Running 'crc config set'"
time="2021-06-28T17:51:09Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:51:09Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:51:09Z" level=debug msg="Running 'crc config set'"
time="2021-06-28T17:51:11Z" level=debug msg="CodeReady Containers version: 1.22.0+6faff76f\n"
time="2021-06-28T17:51:11Z" level=debug msg="OpenShift version: 4.6.15 (embedded in executable)\n"
time="2021-06-28T17:51:11Z" level=debug msg="Running 'crc start'"
time="2021-06-28T17:51:11Z" level=debug msg="Total memory of system is 31396773888 bytes"
time="2021-06-28T17:51:11Z" level=warning msg="A new version (1.28.0) has been published on https://cloud.redhat.com/openshift/install/crc/installer-provisioned"
time="2021-06-28T17:51:11Z" level=info msg="Checking if running as non-root"
time="2021-06-28T17:51:11Z" level=info msg="Checking if podman remote executable is cached"
time="2021-06-28T17:51:11Z" level=debug msg="Currently podman remote is not supported"
time="2021-06-28T17:51:11Z" level=info msg="Checking if admin-helper executable is cached"
time="2021-06-28T17:51:11Z" level=debug msg="Running '/home/crcuser/.crc/bin/admin-helper-linux --version'"
time="2021-06-28T17:51:11Z" level=debug msg="Found admin-helper-linux version 0.0.2"
time="2021-06-28T17:51:11Z" level=debug msg="admin-helper executable already cached"
time="2021-06-28T17:51:11Z" level=info msg="Checking minimum RAM requirements"
time="2021-06-28T17:51:11Z" level=debug msg="Total memory of system is 31396773888 bytes"
time="2021-06-28T17:51:11Z" level=info msg="Checking if Virtualization is enabled"
time="2021-06-28T17:51:11Z" level=debug msg="Checking if the vmx/svm flags are present in /proc/cpuinfo"
time="2021-06-28T17:51:11Z" level=debug msg="CPU virtualization flags are good"
time="2021-06-28T17:51:11Z" level=info msg="Checking if KVM is enabled"
time="2021-06-28T17:51:11Z" level=debug msg="Checking if /dev/kvm exists"
time="2021-06-28T17:51:11Z" level=debug msg="/dev/kvm was found"
time="2021-06-28T17:51:11Z" level=info msg="Checking if libvirt is installed"
time="2021-06-28T17:51:11Z" level=debug msg="Checking if 'virsh' is available"
time="2021-06-28T17:51:11Z" level=debug msg="'virsh' was found in /usr/bin/virsh"
time="2021-06-28T17:51:11Z" level=debug msg="Checking 'virsh capabilities' for libvirtd/qemu availability"
time="2021-06-28T17:51:11Z" level=debug msg="Running 'virsh capabilities'"
time="2021-06-28T17:51:12Z" level=debug msg="Found x86_64 hypervisor with 'hvm' capabilities"
time="2021-06-28T17:51:12Z" level=info msg="Checking if user is part of libvirt group"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if current user is part of the libvirt group"
time="2021-06-28T17:51:12Z" level=debug msg="Current user is already in the libvirt group"
time="2021-06-28T17:51:12Z" level=info msg="Checking if libvirt daemon is running"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if libvirtd service is running"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'systemctl status virtqemud.socket'"
time="2021-06-28T17:51:12Z" level=debug msg="Command failed: exit status 3"
time="2021-06-28T17:51:12Z" level=debug msg="stdout: * virtqemud.socket - Libvirt qemu local socket\n Loaded: loaded (/usr/lib/systemd/system/virtqemud.socket; disabled; vendor preset: disabled)\n Active: inactive (dead)\n Listen: /run/libvirt/virtqemud-sock (Stream)\n"
time="2021-06-28T17:51:12Z" level=debug msg="stderr: "
time="2021-06-28T17:51:12Z" level=debug msg="virtqemud.socket is neither running nor listening"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'systemctl status libvirtd.socket'"
time="2021-06-28T17:51:12Z" level=debug msg="libvirtd.socket is running"
time="2021-06-28T17:51:12Z" level=info msg="Checking if a supported libvirt version is installed"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if libvirt version is >=3.4.0"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'virsh -v'"
time="2021-06-28T17:51:12Z" level=info msg="Checking if crc-driver-libvirt is installed"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if crc-driver-libvirt is installed"
time="2021-06-28T17:51:12Z" level=debug msg="Running '/home/crcuser/.crc/bin/crc-driver-libvirt version'"
time="2021-06-28T17:51:12Z" level=debug msg="Found crc-driver-libvirt version 0.12.14"
time="2021-06-28T17:51:12Z" level=debug msg="crc-driver-libvirt is already installed"
time="2021-06-28T17:51:12Z" level=info msg="Checking if systemd-networkd is running"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if systemd-networkd.service is running"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'systemctl status systemd-networkd.service'"
time="2021-06-28T17:51:12Z" level=debug msg="Command failed: exit status 4"
time="2021-06-28T17:51:12Z" level=debug msg="stdout: "
time="2021-06-28T17:51:12Z" level=debug msg="stderr: Unit systemd-networkd.service could not be found.\n"
time="2021-06-28T17:51:12Z" level=debug msg="systemd-networkd.service is not running"
time="2021-06-28T17:51:12Z" level=info msg="Checking if NetworkManager is installed"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if 'nmcli' is available"
time="2021-06-28T17:51:12Z" level=debug msg="'nmcli' was found in /usr/bin/nmcli"
time="2021-06-28T17:51:12Z" level=info msg="Checking if NetworkManager service is running"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if NetworkManager.service is running"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'systemctl status NetworkManager.service'"
time="2021-06-28T17:51:12Z" level=debug msg="NetworkManager.service is already running"
time="2021-06-28T17:51:12Z" level=info msg="Checking if /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf exists"
time="2021-06-28T17:51:12Z" level=debug msg="Checking NetworkManager configuration"
time="2021-06-28T17:51:12Z" level=debug msg="NetworkManager configuration is good"
time="2021-06-28T17:51:12Z" level=info msg="Checking if /etc/NetworkManager/dnsmasq.d/crc.conf exists"
time="2021-06-28T17:51:12Z" level=debug msg="Checking dnsmasq configuration"
time="2021-06-28T17:51:12Z" level=debug msg="dnsmasq configuration is good"
time="2021-06-28T17:51:12Z" level=info msg="Checking if libvirt 'crc' network is available"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if libvirt 'crc' network exists"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'virsh --connect qemu:///system net-info crc'"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if libvirt 'crc' definition is up to date"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'virsh --connect qemu:///system net-dumpxml --inactive crc'"
time="2021-06-28T17:51:12Z" level=debug msg="libvirt 'crc' network has the expected value"
time="2021-06-28T17:51:12Z" level=info msg="Checking if libvirt 'crc' network is active"
time="2021-06-28T17:51:12Z" level=debug msg="Checking if libvirt 'crc' network is active"
time="2021-06-28T17:51:12Z" level=debug msg="Running 'virsh --connect qemu:///system net-info crc'"
time="2021-06-28T17:51:12Z" level=debug msg="libvirt 'crc' network is already active"
time="2021-06-28T17:51:12Z" level=debug msg="Checking file: /home/crcuser/.crc/machines/crc/.crc-exist"
time="2021-06-28T17:51:12Z" level=debug msg="Using secret from configuration"
time="2021-06-28T17:51:12Z" level=info msg="Loading bundle: crc_libvirt_4.6.15.crcbundle ..."
time="2021-06-28T17:51:12Z" level=info msg="Creating CodeReady Containers VM for OpenShift 4.6.15..."
time="2021-06-28T17:51:12Z" level=debug msg="Found binary path at /home/crcuser/.crc/bin/crc-driver-libvirt"
time="2021-06-28T17:51:12Z" level=debug msg="Launching plugin server for driver libvirt"
time="2021-06-28T17:51:12Z" level=debug msg="Plugin server listening at address 127.0.0.1:44963"
time="2021-06-28T17:51:12Z" level=debug msg="() Calling .GetVersion"
time="2021-06-28T17:51:12Z" level=debug msg="Using API Version 1"
time="2021-06-28T17:51:12Z" level=debug msg="() Calling .SetConfigRaw"
time="2021-06-28T17:51:12Z" level=debug msg="() Calling .GetMachineName"
time="2021-06-28T17:51:12Z" level=debug msg="(crc) Calling .GetMachineName"
time="2021-06-28T17:51:12Z" level=debug msg="(crc) Calling .DriverName"
time="2021-06-28T17:51:12Z" level=debug msg="Running pre-create checks..."
time="2021-06-28T17:51:12Z" level=debug msg="(crc) Calling .PreCreateCheck"
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"About to check libvirt version\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Validating network\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Validating storage pool\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Could not find storage pool 'crc', trying to create it\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Creating storage pool\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=info msg=\"Creating storage pool with XML <pool type=\\\"dir\\\">\\n <name>crc</name>\\n <target>\\n <path>/home/crcuser/.crc/machines/crc</path>\\n </target>\\n</pool>\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Activating pool 'crc'\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) Calling .GetConfigRaw"
time="2021-06-28T17:51:12Z" level=debug msg="Creating machine..."
time="2021-06-28T17:51:12Z" level=debug msg="(crc) Calling .Create"
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Preparing /home/crcuser/.crc/machines/crc/crc.qcow2 for machine use\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"image creation took 20.08234ms\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Verifying executable bit set on /home/crcuser/.crc/machines/crc\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Verifying executable bit set on /home/crcuser/.crc/machines\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Verifying executable bit set on /home/crcuser/.crc\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Setting executable bit set on /home/crcuser/.crc\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Verifying executable bit set on /home/crcuser\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Setting executable bit set on /home/crcuser\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Verifying executable bit set on /home\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Defining VM...\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Found x86_64 hypervisor with 'hvm' capabilities\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Found q35 machine type\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Adding the file: /home/crcuser/.crc/machines/crc/.crc-exist\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"disk image capacity is already 33285996544 bytes\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Starting VM crc\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Validating network\""
time="2021-06-28T17:51:12Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:12Z\" level=debug msg=\"Validating storage pool\""
time="2021-06-28T17:51:19Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:19Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:19Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:19Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:19Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:19Z\" level=debug msg=\"Waiting for machine to come up 0/60\""
time="2021-06-28T17:51:22Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:22Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:22Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:22Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:22Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:22Z\" level=debug msg=\"Waiting for machine to come up 1/60\""
time="2021-06-28T17:51:25Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:25Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:25Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:25Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:25Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:25Z\" level=debug msg=\"Waiting for machine to come up 2/60\""
time="2021-06-28T17:51:28Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:28Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:28Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:28Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:28Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:28Z\" level=debug msg=\"Waiting for machine to come up 3/60\""
time="2021-06-28T17:51:31Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:31Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:31Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:31Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:31Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:31Z\" level=debug msg=\"Waiting for machine to come up 4/60\""
time="2021-06-28T17:51:34Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:34Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:34Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:34Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:34Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:34Z\" level=debug msg=\"Waiting for machine to come up 5/60\""
time="2021-06-28T17:51:37Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:37Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:37Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:37Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:37Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:37Z\" level=debug msg=\"Waiting for machine to come up 6/60\""
time="2021-06-28T17:51:40Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:40Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:40Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:40Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:40Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:40Z\" level=debug msg=\"Waiting for machine to come up 7/60\""
time="2021-06-28T17:51:43Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:43Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:43Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:43Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:43Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:43Z\" level=debug msg=\"Waiting for machine to come up 8/60\""
time="2021-06-28T17:51:46Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:46Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:46Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:46Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:46Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:46Z\" level=debug msg=\"Waiting for machine to come up 9/60\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"IP address: 192.168.130.11\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=info msg=\"Found IP for machine: 192.168.130.11\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) Calling .GetConfigRaw"
time="2021-06-28T17:51:49Z" level=debug msg="Waiting for machine to be running, this may take a few minutes..."
time="2021-06-28T17:51:49Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:51:49Z" level=debug msg="(crc) Calling .GetState"
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:49Z" level=debug msg="Machine is up and running!"
time="2021-06-28T17:51:49Z" level=debug msg="Machine successfully created"
time="2021-06-28T17:51:49Z" level=debug msg="Created /home/crcuser/.crc/machines/crc/.crc-exist"
time="2021-06-28T17:51:49Z" level=debug msg="(crc) Calling .GetState"
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) Calling .GetIP"
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"GetIP called for crc\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"Getting current state...\""
time="2021-06-28T17:51:49Z" level=debug msg="(crc) DBG | time=\"2021-06-28T17:51:49Z\" level=debug msg=\"IP address: 192.168.130.11\""
time="2021-06-28T17:51:49Z" level=debug msg="Waiting until ssh is available"
time="2021-06-28T17:51:49Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:51:49Z" level=debug msg="About to run SSH command:\nexit 0"
time="2021-06-28T17:51:49Z" level=debug msg="Using ssh private keys: [/home/crcuser/.crc/cache/crc_libvirt_4.6.15/id_ecdsa_crc]"
time="2021-06-28T17:51:49Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:49Z" level=info msg="CodeReady Containers VM is running"
time="2021-06-28T17:51:49Z" level=info msg="Generating new SSH Key pair ..."
time="2021-06-28T17:51:49Z" level=debug msg="About to run SSH command:\ncat /home/core/.ssh/authorized_keys"
time="2021-06-28T17:51:49Z" level=debug msg="SSH command results: err: <nil>, output: ecdsa-sha2-nistp521 AAAAE2VjZHNhLXNoYTItbmlzdHA1MjEAAAAIbmlzdHA1MjEAAACFBABGZ9UzRot3WyJcSNTfnlfBv1/DauGGercxF2p15FL91caFiYmXZMphexQLleYfr4Js3wTw4DLK9nSeHHQ7bKafQQEkGzM16F6xEZfbtIJWs3hu4M71a87bp/8F6P7UMR7IPYcl1ZfQp1eXiO9XNy59JlDyyXXJq43FDuiXBPlXiewm2w== core\n"
time="2021-06-28T17:51:49Z" level=info msg="Updating authorized keys ..."
time="2021-06-28T17:51:49Z" level=debug msg="About to run SSH command:\necho 'ecdsa-sha2-nistp521 AAAAE2VjZHNhLXNoYTItbmlzdHA1MjEAAAAIbmlzdHA1MjEAAACFBACYn3FsCs47KizAwbhI7NsK4SuX8hh1cIEbafmQi5EMYf11VzNFBPPO6gX1fWagjBIiyzwqGYAwDuul+gpku/IL7wEyUovQoUk0V+IVarS1rPoNLtN5OzsyhkVA6S2SlgUdb9HqX8w2zPlC6kCZq7ovWufH9uYO+DrkKKCMx3rSfmscPA==\n' > /home/core/.ssh/authorized_keys; chmod 644 /home/core/.ssh/authorized_keys"
time="2021-06-28T17:51:49Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:49Z" level=info msg="Copying kubeconfig file to instance dir ..."
time="2021-06-28T17:51:49Z" level=debug msg="Copying '/home/crcuser/.crc/cache/crc_libvirt_4.6.15/kubeconfig' to '/home/crcuser/.crc/machines/crc/kubeconfig'"
time="2021-06-28T17:51:49Z" level=debug msg="About to run SSH command:\nsudo xfs_growfs / >/dev/null"
time="2021-06-28T17:51:49Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:49Z" level=info msg="Starting network time synchronization in CodeReady Containers VM"
time="2021-06-28T17:51:49Z" level=debug msg="About to run SSH command:\nsudo timedatectl set-ntp on"
time="2021-06-28T17:51:50Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:50Z" level=debug msg="Creating /var/srv/dnsmasq.conf with permissions 0644 in the CRC VM"
time="2021-06-28T17:51:50Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:51:50Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:51:50Z" level=debug msg="About to run SSH command:\nsudo podman rm -f dnsmasq"
time="2021-06-28T17:51:50Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:51:50Z" level=debug msg="About to run SSH command:\nsudo rm -f /var/lib/cni/networks/podman/10.88.0.8"
time="2021-06-28T17:51:50Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:50Z" level=debug msg="About to run SSH command:\nsudo podman run --ip 10.88.0.8 --name dnsmasq -v /var/srv/dnsmasq.conf:/etc/dnsmasq.conf -p 53:53/udp --privileged -d quay.io/crcont/dnsmasq:latest"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: ae1a2e61714c8570b70550ca569fda6d6f072d8fb4d0d63205169c2c97e9c96b\n"
time="2021-06-28T17:51:52Z" level=debug msg="Running '/home/crcuser/.crc/bin/admin-helper-linux rm api.crc.testing oauth-openshift.apps-crc.testing console-openshift-console.apps-crc.testing default-route-openshift-image-registry.apps-crc.testing'"
time="2021-06-28T17:51:52Z" level=debug msg="Running '/home/crcuser/.crc/bin/admin-helper-linux add 192.168.130.11 api.crc.testing oauth-openshift.apps-crc.testing console-openshift-console.apps-crc.testing default-route-openshift-image-registry.apps-crc.testing'"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\ncat /etc/resolv.conf"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: # Generated by NetworkManager\nnameserver 192.168.130.1\n"
time="2021-06-28T17:51:52Z" level=debug msg="Creating /etc/resolv.conf with permissions 0644 in the CRC VM"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:51:52Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\nhost -R 3 foo.apps-crc.testing"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: foo.apps-crc.testing has address 192.168.130.11\n"
time="2021-06-28T17:51:52Z" level=info msg="Check internal and public DNS query ..."
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\nhost -R 3 quay.io"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: quay.io has address 3.216.152.103\nquay.io has address 44.193.101.5\nquay.io has address 3.213.173.170\nquay.io has address 34.224.196.162\nquay.io has address 54.156.10.58\nquay.io has address 50.16.140.223\nquay.io has address 54.197.99.84\nquay.io has address 3.233.133.41\nquay.io mail is handled by 10 aspmx.l.google.com.\nquay.io mail is handled by 20 alt1.aspmx.l.google.com.\nquay.io mail is handled by 20 alt2.aspmx.l.google.com.\nquay.io mail is handled by 30 aspmx2.googlemail.com.\nquay.io mail is handled by 30 aspmx3.googlemail.com.\n"
time="2021-06-28T17:51:52Z" level=info msg="Check DNS query from host ..."
time="2021-06-28T17:51:52Z" level=debug msg="api.crc.testing resolved to [192.168.130.11]"
time="2021-06-28T17:51:52Z" level=debug msg="foo.apps-crc.testing resolved to [192.168.130.11]"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\ntest -e /var/lib/kubelet/config.json"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:51:52Z" level=info msg="Adding user's pull secret to instance disk..."
time="2021-06-28T17:51:52Z" level=debug msg="Creating /var/lib/kubelet/config.json with permissions 0600 in the CRC VM"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:51:52Z" level=info msg="Verifying validity of the kubelet certificates ..."
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:51:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:51:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:51:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:51:52Z" level=info msg="Starting OpenShift kubelet service"
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\nsudo systemctl daemon-reload"
time="2021-06-28T17:51:52Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:51:52Z" level=debug msg="About to run SSH command:\nsudo systemctl start kubelet"
time="2021-06-28T17:52:02Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:52:02Z" level=info msg="Kubelet client certificate has expired, renewing it... [will take up to 8 minutes]"
time="2021-06-28T17:52:02Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:52:02Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:03Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:03Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:08Z" level=debug msg="retry loop: attempt 1"
time="2021-06-28T17:52:08Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:30Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:30Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:35Z" level=debug msg="retry loop: attempt 2"
time="2021-06-28T17:52:35Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:36Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:36Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:41Z" level=debug msg="retry loop: attempt 3"
time="2021-06-28T17:52:41Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:42Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:42Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:47Z" level=debug msg="retry loop: attempt 4"
time="2021-06-28T17:52:47Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:47Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:47Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:52Z" level=debug msg="retry loop: attempt 5"
time="2021-06-28T17:52:52Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:52Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:52Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:52:57Z" level=debug msg="retry loop: attempt 6"
time="2021-06-28T17:52:57Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:52:57Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:52:57Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:02Z" level=debug msg="retry loop: attempt 7"
time="2021-06-28T17:53:02Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:03Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:03Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:08Z" level=debug msg="retry loop: attempt 8"
time="2021-06-28T17:53:08Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:08Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:08Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:13Z" level=debug msg="retry loop: attempt 9"
time="2021-06-28T17:53:13Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:13Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:13Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:18Z" level=debug msg="retry loop: attempt 10"
time="2021-06-28T17:53:18Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:18Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:18Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:23Z" level=debug msg="retry loop: attempt 11"
time="2021-06-28T17:53:23Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:23Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:23Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:28Z" level=debug msg="retry loop: attempt 12"
time="2021-06-28T17:53:28Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:29Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:29Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:34Z" level=debug msg="retry loop: attempt 13"
time="2021-06-28T17:53:34Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:34Z" level=debug msg="SSH command results: err: Process exited with status 1, output: "
time="2021-06-28T17:53:34Z" level=debug msg="error: Temporary error: ssh command error:\ncommand : oc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig\nerr : Process exited with status 1\\n - sleeping 5s"
time="2021-06-28T17:53:39Z" level=debug msg="retry loop: attempt 14"
time="2021-06-28T17:53:39Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:40Z" level=debug msg="SSH command results: err: <nil>, output: NAME AGE SIGNERNAME REQUESTOR CONDITION\ncsr-8flp2 145d kubernetes.io/kube-apiserver-client-kubelet system:serviceaccount:openshift-machine-config-operator:node-bootstrapper Approved,Issued\ncsr-q8zdg 146d kubernetes.io/kube-apiserver-client-kubelet system:serviceaccount:openshift-machine-config-operator:node-bootstrapper Approved,Issued\ncsr-t4km6 146d kubernetes.io/kubelet-serving system:node:crc-ctj2r-master-0 Approved,Issued\ncsr-xnpv9 145d kubernetes.io/kubelet-serving system:node:crc-ctj2r-master-0 Approved,Issued\n"
time="2021-06-28T17:53:40Z" level=debug msg="error: Temporary error: No Pending CSR with signerName kubernetes.io/kube-apiserver-client-kubelet - sleeping 5s"
time="2021-06-28T17:53:45Z" level=debug msg="retry loop: attempt 15"
time="2021-06-28T17:53:45Z" level=debug msg="About to run SSH command:\noc get csr --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:45Z" level=debug msg="SSH command results: err: <nil>, output: NAME AGE SIGNERNAME REQUESTOR CONDITION\ncsr-8flp2 145d kubernetes.io/kube-apiserver-client-kubelet system:serviceaccount:openshift-machine-config-operator:node-bootstrapper Approved,Issued\ncsr-q8zdg 146d kubernetes.io/kube-apiserver-client-kubelet system:serviceaccount:openshift-machine-config-operator:node-bootstrapper Approved,Issued\ncsr-shb8h 3s kubernetes.io/kube-apiserver-client-kubelet system:serviceaccount:openshift-machine-config-operator:node-bootstrapper Pending\ncsr-t4km6 146d kubernetes.io/kubelet-serving system:node:crc-ctj2r-master-0 Approved,Issued\ncsr-xnpv9 145d kubernetes.io/kubelet-serving system:node:crc-ctj2r-master-0 Approved,Issued\n"
time="2021-06-28T17:53:45Z" level=debug msg="Approving pending CSRs"
time="2021-06-28T17:53:45Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:53:46Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:53:46Z" level=debug msg="Approving csr csr-shb8h (signerName: kubernetes.io/kube-apiserver-client-kubelet)"
time="2021-06-28T17:53:46Z" level=debug msg="About to run SSH command:\noc adm certificate approve csr-shb8h --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:53:46Z" level=debug msg="SSH command results: err: <nil>, output: certificatesigningrequest.certificates.k8s.io/csr-shb8h approved\n"
time="2021-06-28T17:53:46Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:53:46Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:53:46Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:53:46Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:53:46Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:53:51Z" level=debug msg="retry loop: attempt 1"
time="2021-06-28T17:53:51Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:53:51Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:53:51Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:53:51Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:53:56Z" level=debug msg="retry loop: attempt 2"
time="2021-06-28T17:53:56Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:53:56Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:53:56Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:53:56Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:01Z" level=debug msg="retry loop: attempt 3"
time="2021-06-28T17:54:01Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:02Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:02Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:02Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:07Z" level=debug msg="retry loop: attempt 4"
time="2021-06-28T17:54:07Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:07Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:07Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:07Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:12Z" level=debug msg="retry loop: attempt 5"
time="2021-06-28T17:54:12Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:12Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:12Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:12Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:17Z" level=debug msg="retry loop: attempt 6"
time="2021-06-28T17:54:17Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:17Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:17Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:17Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:22Z" level=debug msg="retry loop: attempt 7"
time="2021-06-28T17:54:22Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:22Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:22Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:22Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:27Z" level=debug msg="retry loop: attempt 8"
time="2021-06-28T17:54:27Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:27Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:27Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:27Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:32Z" level=debug msg="retry loop: attempt 9"
time="2021-06-28T17:54:32Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:32Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:32Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:32Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:37Z" level=debug msg="retry loop: attempt 10"
time="2021-06-28T17:54:37Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:37Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:37Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:37Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:42Z" level=debug msg="retry loop: attempt 11"
time="2021-06-28T17:54:42Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:42Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:42Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:42Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:47Z" level=debug msg="retry loop: attempt 12"
time="2021-06-28T17:54:47Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:47Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:47Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:47Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:52Z" level=debug msg="retry loop: attempt 13"
time="2021-06-28T17:54:52Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:52Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:54:57Z" level=debug msg="retry loop: attempt 14"
time="2021-06-28T17:54:57Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:54:57Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:54:57Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:54:57Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:02Z" level=debug msg="retry loop: attempt 15"
time="2021-06-28T17:55:02Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:02Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:02Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:02Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:07Z" level=debug msg="retry loop: attempt 16"
time="2021-06-28T17:55:07Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:07Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:07Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:07Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:12Z" level=debug msg="retry loop: attempt 17"
time="2021-06-28T17:55:12Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:12Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:12Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:12Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:17Z" level=debug msg="retry loop: attempt 18"
time="2021-06-28T17:55:17Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:17Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:17Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:17Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:22Z" level=debug msg="retry loop: attempt 19"
time="2021-06-28T17:55:22Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:23Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:23Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:23Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:28Z" level=debug msg="retry loop: attempt 20"
time="2021-06-28T17:55:28Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:28Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:28Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:28Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:33Z" level=debug msg="retry loop: attempt 21"
time="2021-06-28T17:55:33Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:33Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:33Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:33Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:38Z" level=debug msg="retry loop: attempt 22"
time="2021-06-28T17:55:38Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:38Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:38Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:38Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:43Z" level=debug msg="retry loop: attempt 23"
time="2021-06-28T17:55:43Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:43Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:43Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:43Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:48Z" level=debug msg="retry loop: attempt 24"
time="2021-06-28T17:55:48Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:48Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:48Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:48Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:53Z" level=debug msg="retry loop: attempt 25"
time="2021-06-28T17:55:53Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:53Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:53Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:53Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:55:58Z" level=debug msg="retry loop: attempt 26"
time="2021-06-28T17:55:58Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:55:58Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:55:58Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:55:58Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:03Z" level=debug msg="retry loop: attempt 27"
time="2021-06-28T17:56:03Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:03Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:03Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:03Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:08Z" level=debug msg="retry loop: attempt 28"
time="2021-06-28T17:56:08Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:08Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:08Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:08Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:13Z" level=debug msg="retry loop: attempt 29"
time="2021-06-28T17:56:13Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:13Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:13Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:13Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:18Z" level=debug msg="retry loop: attempt 30"
time="2021-06-28T17:56:18Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:18Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:18Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:18Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:23Z" level=debug msg="retry loop: attempt 31"
time="2021-06-28T17:56:23Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:23Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:23Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:23Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:28Z" level=debug msg="retry loop: attempt 32"
time="2021-06-28T17:56:28Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:28Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:28Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:28Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:33Z" level=debug msg="retry loop: attempt 33"
time="2021-06-28T17:56:33Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:33Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:33Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:33Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:38Z" level=debug msg="retry loop: attempt 34"
time="2021-06-28T17:56:38Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:39Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:39Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:39Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:44Z" level=debug msg="retry loop: attempt 35"
time="2021-06-28T17:56:44Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:44Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:44Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:44Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:49Z" level=debug msg="retry loop: attempt 36"
time="2021-06-28T17:56:49Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:49Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:49Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:49Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:54Z" level=debug msg="retry loop: attempt 37"
time="2021-06-28T17:56:54Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:54Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:54Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:54Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:56:59Z" level=debug msg="retry loop: attempt 38"
time="2021-06-28T17:56:59Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:56:59Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:56:59Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:56:59Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:04Z" level=debug msg="retry loop: attempt 39"
time="2021-06-28T17:57:04Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:04Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:04Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:04Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:09Z" level=debug msg="retry loop: attempt 40"
time="2021-06-28T17:57:09Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:09Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:09Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:09Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:14Z" level=debug msg="retry loop: attempt 41"
time="2021-06-28T17:57:14Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:14Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:14Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:14Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:19Z" level=debug msg="retry loop: attempt 42"
time="2021-06-28T17:57:19Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:19Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:19Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:19Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:24Z" level=debug msg="retry loop: attempt 43"
time="2021-06-28T17:57:24Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:24Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:24Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:24Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:29Z" level=debug msg="retry loop: attempt 44"
time="2021-06-28T17:57:29Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:29Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:52:28+00:00\n"
time="2021-06-28T17:57:29Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:52 UTC"
time="2021-06-28T17:57:29Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-client-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:34Z" level=debug msg="retry loop: attempt 45"
time="2021-06-28T17:57:34Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-client-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:34Z" level=debug msg="SSH command results: err: <nil>, output: 2021-07-28T17:52:29+00:00\n"
time="2021-06-28T17:57:34Z" level=info msg="Kubelet serving certificate has expired, waiting for automatic renewal... [will take up to 8 minutes]"
time="2021-06-28T17:57:34Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:57:34Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:34Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:57:34Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:57:34Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:39Z" level=debug msg="retry loop: attempt 1"
time="2021-06-28T17:57:39Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:40Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:57:40Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:57:40Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:45Z" level=debug msg="retry loop: attempt 2"
time="2021-06-28T17:57:45Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:45Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:57:45Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:57:45Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:50Z" level=debug msg="retry loop: attempt 3"
time="2021-06-28T17:57:50Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:50Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:57:50Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:57:50Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:57:55Z" level=debug msg="retry loop: attempt 4"
time="2021-06-28T17:57:55Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:57:55Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:57:55Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:57:55Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:58:00Z" level=debug msg="retry loop: attempt 5"
time="2021-06-28T17:58:00Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:58:00Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:58:00Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:58:00Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:58:05Z" level=debug msg="retry loop: attempt 6"
time="2021-06-28T17:58:05Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:58:05Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:58:05Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:58:05Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:58:10Z" level=debug msg="retry loop: attempt 7"
time="2021-06-28T17:58:10Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:58:10Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:58:10Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:58:10Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:58:15Z" level=debug msg="retry loop: attempt 8"
time="2021-06-28T17:58:15Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:58:15Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:55:09+00:00\n"
time="2021-06-28T17:58:15Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:55 UTC"
time="2021-06-28T17:58:15Z" level=debug msg="error: Temporary error: certificate /var/lib/kubelet/pki/kubelet-server-current.pem still expired - sleeping 5s"
time="2021-06-28T17:58:20Z" level=debug msg="retry loop: attempt 9"
time="2021-06-28T17:58:20Z" level=debug msg="About to run SSH command:\ndate --date=\"$(sudo openssl x509 -in /var/lib/kubelet/pki/kubelet-server-current.pem -noout -enddate | cut -d= -f 2)\" --iso-8601=seconds"
time="2021-06-28T17:58:20Z" level=debug msg="SSH command results: err: <nil>, output: 2021-07-28T17:53:20+00:00\n"
time="2021-06-28T17:58:20Z" level=debug msg="Waiting for apiserver availability"
time="2021-06-28T17:58:20Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:58:20Z" level=debug msg="About to run SSH command:\noc get nodes --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:58:22Z" level=debug msg="SSH command results: err: <nil>, output: NAME STATUS ROLES AGE VERSION\ncrc-ctj2r-master-0 Ready master,worker 146d v1.19.0+1833054\n"
time="2021-06-28T17:58:22Z" level=debug msg="NAME STATUS ROLES AGE VERSION\ncrc-ctj2r-master-0 Ready master,worker 146d v1.19.0+1833054\n"
time="2021-06-28T17:58:22Z" level=debug msg="Waiting for availability of resource type 'secret'"
time="2021-06-28T17:58:22Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:58:22Z" level=debug msg="About to run SSH command:\noc get secret --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:58:23Z" level=debug msg="SSH command results: err: <nil>, output: NAME TYPE DATA AGE\nbuilder-dockercfg-67pbn kubernetes.io/dockercfg 1 146d\nbuilder-token-7dpgv kubernetes.io/service-account-token 4 146d\nbuilder-token-crhrm kubernetes.io/service-account-token 4 146d\ndefault-dockercfg-qlhc5 kubernetes.io/dockercfg 1 146d\ndefault-token-4bcxf kubernetes.io/service-account-token 4 146d\ndefault-token-66jc2 kubernetes.io/service-account-token 4 146d\ndeployer-dockercfg-7gpfr kubernetes.io/dockercfg 1 146d\ndeployer-token-2xkxq kubernetes.io/service-account-token 4 146d\ndeployer-token-vpvdw kubernetes.io/service-account-token 4 146d\n"
time="2021-06-28T17:58:23Z" level=debug msg="NAME TYPE DATA AGE\nbuilder-dockercfg-67pbn kubernetes.io/dockercfg 1 146d\nbuilder-token-7dpgv kubernetes.io/service-account-token 4 146d\nbuilder-token-crhrm kubernetes.io/service-account-token 4 146d\ndefault-dockercfg-qlhc5 kubernetes.io/dockercfg 1 146d\ndefault-token-4bcxf kubernetes.io/service-account-token 4 146d\ndefault-token-66jc2 kubernetes.io/service-account-token 4 146d\ndeployer-dockercfg-7gpfr kubernetes.io/dockercfg 1 146d\ndeployer-token-2xkxq kubernetes.io/service-account-token 4 146d\ndeployer-token-vpvdw kubernetes.io/service-account-token 4 146d\n"
time="2021-06-28T17:58:23Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:58:24Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:58:24Z" level=info msg="Adding user's pull secret to the cluster ..."
time="2021-06-28T17:58:24Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T17:58:26Z" level=debug msg="SSH command succeeded"
time="2021-06-28T17:58:26Z" level=debug msg="Waiting for availability of resource type 'clusterversion'"
time="2021-06-28T17:58:26Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:58:26Z" level=debug msg="About to run SSH command:\noc get clusterversion --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:58:27Z" level=debug msg="SSH command results: err: <nil>, output: NAME VERSION AVAILABLE PROGRESSING SINCE STATUS\nversion 4.6.15 True False 146d Error while reconciling 4.6.15: the cluster operator monitoring is degraded\n"
time="2021-06-28T17:58:27Z" level=debug msg="NAME VERSION AVAILABLE PROGRESSING SINCE STATUS\nversion 4.6.15 True False 146d Error while reconciling 4.6.15: the cluster operator monitoring is degraded\n"
time="2021-06-28T17:58:27Z" level=debug msg="About to run SSH command:\noc get clusterversion version -o jsonpath=\"{['spec']['clusterID']}\" --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:58:29Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T17:58:29Z" level=info msg="Updating cluster ID ..."
time="2021-06-28T17:58:29Z" level=debug msg="About to run SSH command:\noc patch clusterversion version -p '{\"spec\":{\"clusterID\":\"fda0ae1e-92aa-41f0-8566-fbc50d58dfa9\"}}' --type merge --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T17:58:30Z" level=debug msg="SSH command results: err: <nil>, output: clusterversion.config.openshift.io/version patched\n"
time="2021-06-28T17:58:30Z" level=debug msg="Waiting for the renewal of the request header client ca..."
time="2021-06-28T17:58:30Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T17:58:30Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:31Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:31Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:31Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:33Z" level=debug msg="retry loop: attempt 1"
time="2021-06-28T17:58:33Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:33Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:33Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:33Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:35Z" level=debug msg="retry loop: attempt 2"
time="2021-06-28T17:58:35Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:35Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:35Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:35Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:37Z" level=debug msg="retry loop: attempt 3"
time="2021-06-28T17:58:37Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:38Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:38Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:38Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:40Z" level=debug msg="retry loop: attempt 4"
time="2021-06-28T17:58:40Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:40Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:40Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:40Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:42Z" level=debug msg="retry loop: attempt 5"
time="2021-06-28T17:58:42Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:42Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:42Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:42Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:44Z" level=debug msg="retry loop: attempt 6"
time="2021-06-28T17:58:44Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:44Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:44Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:44Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:46Z" level=debug msg="retry loop: attempt 7"
time="2021-06-28T17:58:46Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:47Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:47Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:47Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:49Z" level=debug msg="retry loop: attempt 8"
time="2021-06-28T17:58:49Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:50Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:50Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:50Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:52Z" level=debug msg="retry loop: attempt 9"
time="2021-06-28T17:58:52Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:52Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:54Z" level=debug msg="retry loop: attempt 10"
time="2021-06-28T17:58:54Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:54Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:54Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:54Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:56Z" level=debug msg="retry loop: attempt 11"
time="2021-06-28T17:58:56Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:56Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:56Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:56Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:58:58Z" level=debug msg="retry loop: attempt 12"
time="2021-06-28T17:58:58Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:58:58Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:58:58Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:58:58Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:00Z" level=debug msg="retry loop: attempt 13"
time="2021-06-28T17:59:00Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:00Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:00Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:00Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:02Z" level=debug msg="retry loop: attempt 14"
time="2021-06-28T17:59:02Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:03Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:03Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:03Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:05Z" level=debug msg="retry loop: attempt 15"
time="2021-06-28T17:59:05Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:05Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:05Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:05Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:07Z" level=debug msg="retry loop: attempt 16"
time="2021-06-28T17:59:07Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:07Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:07Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:07Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:09Z" level=debug msg="retry loop: attempt 17"
time="2021-06-28T17:59:09Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:09Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:09Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:09Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:11Z" level=debug msg="retry loop: attempt 18"
time="2021-06-28T17:59:11Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:11Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:11Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:11Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:13Z" level=debug msg="retry loop: attempt 19"
time="2021-06-28T17:59:13Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:13Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:13Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:13Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:15Z" level=debug msg="retry loop: attempt 20"
time="2021-06-28T17:59:15Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:16Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:16Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:16Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:18Z" level=debug msg="retry loop: attempt 21"
time="2021-06-28T17:59:18Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:18Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:18Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:18Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:20Z" level=debug msg="retry loop: attempt 22"
time="2021-06-28T17:59:20Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:20Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:20Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:20Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:22Z" level=debug msg="retry loop: attempt 23"
time="2021-06-28T17:59:22Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:22Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:22Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:22Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:24Z" level=debug msg="retry loop: attempt 24"
time="2021-06-28T17:59:24Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:24Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:24Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:24Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:26Z" level=debug msg="retry loop: attempt 25"
time="2021-06-28T17:59:26Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:26Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:26Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:26Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:28Z" level=debug msg="retry loop: attempt 26"
time="2021-06-28T17:59:28Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:28Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:28Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:28Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:30Z" level=debug msg="retry loop: attempt 27"
time="2021-06-28T17:59:30Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:31Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:31Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:31Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:33Z" level=debug msg="retry loop: attempt 28"
time="2021-06-28T17:59:33Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:33Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:33Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:33Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:35Z" level=debug msg="retry loop: attempt 29"
time="2021-06-28T17:59:35Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:35Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:35Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:35Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:37Z" level=debug msg="retry loop: attempt 30"
time="2021-06-28T17:59:37Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:37Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:37Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:37Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:39Z" level=debug msg="retry loop: attempt 31"
time="2021-06-28T17:59:39Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:39Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:39Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:39Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:41Z" level=debug msg="retry loop: attempt 32"
time="2021-06-28T17:59:41Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:41Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:41Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:41Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:43Z" level=debug msg="retry loop: attempt 33"
time="2021-06-28T17:59:43Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:43Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:43Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:43Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:45Z" level=debug msg="retry loop: attempt 34"
time="2021-06-28T17:59:45Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:45Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:45Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:45Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:47Z" level=debug msg="retry loop: attempt 35"
time="2021-06-28T17:59:47Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:47Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:47Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:47Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:49Z" level=debug msg="retry loop: attempt 36"
time="2021-06-28T17:59:49Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:50Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:50Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:50Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:52Z" level=debug msg="retry loop: attempt 37"
time="2021-06-28T17:59:52Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:52Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:52Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:52Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:54Z" level=debug msg="retry loop: attempt 38"
time="2021-06-28T17:59:54Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:54Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:54Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:54Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:56Z" level=debug msg="retry loop: attempt 39"
time="2021-06-28T17:59:56Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:56Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:56Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:56Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T17:59:58Z" level=debug msg="retry loop: attempt 40"
time="2021-06-28T17:59:58Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T17:59:58Z" level=debug msg="SSH command results: err: <nil>, output: 2021-03-05T06:58:21+00:00\n"
time="2021-06-28T17:59:58Z" level=debug msg="Certs have expired, they were valid till: 05 Mar 21 06:58 UTC"
time="2021-06-28T17:59:58Z" level=debug msg="error: Temporary error: certificate still expired - sleeping 2s"
time="2021-06-28T18:00:00Z" level=debug msg="retry loop: attempt 41"
time="2021-06-28T18:00:00Z" level=debug msg="About to run SSH command:\ndate --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"
time="2021-06-28T18:00:00Z" level=debug msg="SSH command results: err: <nil>, output: 2021-07-28T17:52:41+00:00\n"
time="2021-06-28T18:00:00Z" level=debug msg="Waiting for availability of resource type 'pod'"
time="2021-06-28T18:00:00Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T18:00:00Z" level=debug msg="About to run SSH command:\noc get pod --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T18:00:02Z" level=debug msg="SSH command results: err: <nil>, output: "
time="2021-06-28T18:00:02Z" level=debug
time="2021-06-28T18:00:02Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T18:00:02Z" level=debug msg="About to run SSH command:\noc delete pod --all -n openshift-apiserver --context admin --cluster crc --kubeconfig /opt/kubeconfig"
time="2021-06-28T18:00:12Z" level=debug msg="SSH command results: err: <nil>, output: pod \"apiserver-bc6c767b-mlxhj\" deleted\n"
time="2021-06-28T18:00:12Z" level=info msg="Starting OpenShift cluster ... [waiting 3m]"
time="2021-06-28T18:03:12Z" level=info msg="Updating kubeconfig"
time="2021-06-28T18:03:12Z" level=debug msg="retry loop: attempt 0"
time="2021-06-28T18:03:12Z" level=debug msg="About to run SSH command with hidden output"
time="2021-06-28T18:03:16Z" level=debug msg="SSH command succeeded"
time="2021-06-28T18:03:16Z" level=warning msg="Cannot update kubeconfig: Head \"https://oauth-openshift.apps-crc.testing\": dial tcp 192.168.130.11:443: connect: connection refused"
time="2021-06-28T18:03:16Z" level=warning msg="The cluster might report a degraded or error state. This is expected since several operators have been disabled to lower the resource usage. For more information, please consult the documentation"
time="2021-06-28T18:03:16Z" level=debug msg="Making call to close driver server"
time="2021-06-28T18:03:16Z" level=debug msg="(crc) Calling .Close"
time="2021-06-28T18:03:16Z" level=debug msg="(crc) DBG | time=\"2021-06-28T18:03:16Z\" level=debug msg=\"Closing plugin on server side\""
time="2021-06-28T18:03:16Z" level=debug msg="Successfully made call to close driver server"
time="2021-06-28T18:03:16Z" level=debug msg="Making call to close connection to plugin binary"
apiVersion: v1
kind: Pod
metadata:
annotations:
k8s.v1.cni.cncf.io/network-status: |-
[{
"name": "",
"interface": "eth0",
"ips": [
"10.217.0.42"
],
"default": true,
"dns": {}
}]
k8s.v1.cni.cncf.io/networks-status: |-
[{
"name": "",
"interface": "eth0",
"ips": [
"10.217.0.42"
],
"default": true,
"dns": {}
}]
openshift.io/scc: anyuid
creationTimestamp: "2021-02-03T08:03:40Z"
generateName: redhat-operators-
labels:
catalogsource.operators.coreos.com/update: redhat-operators
olm.catalogSource: ""
managedFields:
- apiVersion: v1
fieldsType: FieldsV1
fieldsV1:
f:metadata:
f:generateName: {}
f:labels:
.: {}
f:catalogsource.operators.coreos.com/update: {}
f:olm.catalogSource: {}
f:ownerReferences:
.: {}
k:{"uid":"a0413618-02d9-4e64-8ad5-336e7f98beb5"}:
.: {}
f:apiVersion: {}
f:blockOwnerDeletion: {}
f:controller: {}
f:kind: {}
f:name: {}
f:uid: {}
f:spec:
f:containers:
k:{"name":"registry-server"}:
.: {}
f:image: {}
f:imagePullPolicy: {}
f:livenessProbe:
.: {}
f:exec:
.: {}
f:command: {}
f:failureThreshold: {}
f:initialDelaySeconds: {}
f:periodSeconds: {}
f:successThreshold: {}
f:timeoutSeconds: {}
f:name: {}
f:ports:
.: {}
k:{"containerPort":50051,"protocol":"TCP"}:
.: {}
f:containerPort: {}
f:name: {}
f:protocol: {}
f:readinessProbe:
.: {}
f:exec:
.: {}
f:command: {}
f:failureThreshold: {}
f:initialDelaySeconds: {}
f:periodSeconds: {}
f:successThreshold: {}
f:timeoutSeconds: {}
f:resources:
.: {}
f:requests:
.: {}
f:cpu: {}
f:memory: {}
f:terminationMessagePath: {}
f:terminationMessagePolicy: {}
f:dnsPolicy: {}
f:enableServiceLinks: {}
f:nodeSelector:
.: {}
f:kubernetes.io/os: {}
f:restartPolicy: {}
f:schedulerName: {}
f:securityContext: {}
f:terminationGracePeriodSeconds: {}
manager: catalog
operation: Update
time: "2021-02-03T08:03:40Z"
- apiVersion: v1
fieldsType: FieldsV1
fieldsV1:
f:status:
f:conditions:
.: {}
k:{"type":"PodScheduled"}:
.: {}
f:lastProbeTime: {}
f:lastTransitionTime: {}
f:message: {}
f:reason: {}
f:status: {}
f:type: {}
manager: kube-scheduler
operation: Update
time: "2021-02-03T08:03:40Z"
- apiVersion: v1
fieldsType: FieldsV1
fieldsV1:
f:metadata:
f:annotations:
f:k8s.v1.cni.cncf.io/network-status: {}
f:k8s.v1.cni.cncf.io/networks-status: {}
manager: multus
operation: Update
time: "2021-06-28T17:58:40Z"
- apiVersion: v1
fieldsType: FieldsV1
fieldsV1:
f:status:
f:conditions:
k:{"type":"ContainersReady"}:
.: {}
f:lastProbeTime: {}
f:lastTransitionTime: {}
f:message: {}
f:reason: {}
f:status: {}
f:type: {}
k:{"type":"Initialized"}:
.: {}
f:lastProbeTime: {}
f:lastTransitionTime: {}
f:status: {}
f:type: {}
k:{"type":"Ready"}:
.: {}
f:lastProbeTime: {}
f:lastTransitionTime: {}
f:message: {}
f:reason: {}
f:status: {}
f:type: {}
f:containerStatuses: {}
f:hostIP: {}
f:podIP: {}
f:podIPs:
.: {}
k:{"ip":"10.217.0.42"}:
.: {}
f:ip: {}
f:startTime: {}
manager: kubelet
operation: Update
time: "2021-06-28T18:06:55Z"
name: redhat-operators-dc7tb
namespace: openshift-marketplace
ownerReferences:
- apiVersion: operators.coreos.com/v1alpha1
blockOwnerDeletion: false
controller: false
kind: CatalogSource
name: redhat-operators
uid: a0413618-02d9-4e64-8ad5-336e7f98beb5
resourceVersion: "46659"
selfLink: /api/v1/namespaces/openshift-marketplace/pods/redhat-operators-dc7tb
uid: 833bd47c-7c5b-49c9-aa07-92366e9984e9
spec:
containers:
- image: registry.redhat.io/redhat/redhat-operator-index:v4.6
imagePullPolicy: Always
livenessProbe:
exec:
command:
- grpc_health_probe
- -addr=:50051
failureThreshold: 3
initialDelaySeconds: 10
periodSeconds: 10
successThreshold: 1
timeoutSeconds: 1
name: registry-server
ports:
- containerPort: 50051
name: grpc
protocol: TCP
readinessProbe:
exec:
command:
- grpc_health_probe
- -addr=:50051
failureThreshold: 3
initialDelaySeconds: 5
periodSeconds: 10
successThreshold: 1
timeoutSeconds: 5
resources:
requests:
cpu: 10m
memory: 50Mi
securityContext:
capabilities:
drop:
- MKNOD
terminationMessagePath: /dev/termination-log
terminationMessagePolicy: File
volumeMounts:
- mountPath: /var/run/secrets/kubernetes.io/serviceaccount
name: default-token-wshv9
readOnly: true
dnsPolicy: ClusterFirst
enableServiceLinks: true
imagePullSecrets:
- name: default-dockercfg-n4lfc
nodeName: crc-ctj2r-master-0
nodeSelector:
kubernetes.io/os: linux
preemptionPolicy: PreemptLowerPriority
priority: 0
restartPolicy: Always
schedulerName: default-scheduler
securityContext:
seLinuxOptions:
level: s0:c14,c4
serviceAccount: default
serviceAccountName: default
terminationGracePeriodSeconds: 30
tolerations:
- effect: NoExecute
key: node.kubernetes.io/not-ready
operator: Exists
tolerationSeconds: 300
- effect: NoExecute
key: node.kubernetes.io/unreachable
operator: Exists
tolerationSeconds: 300
- effect: NoSchedule
key: node.kubernetes.io/memory-pressure
operator: Exists
volumes:
- name: default-token-wshv9
secret:
defaultMode: 420
secretName: default-token-wshv9
status:
conditions:
- lastProbeTime: null
lastTransitionTime: "2021-06-28T17:58:29Z"
status: "True"
type: Initialized
- lastProbeTime: null
lastTransitionTime: "2021-06-28T17:58:29Z"
message: 'containers with unready status: [registry-server]'
reason: ContainersNotReady
status: "False"
type: Ready
- lastProbeTime: null
lastTransitionTime: "2021-06-28T17:58:29Z"
message: 'containers with unready status: [registry-server]'
reason: ContainersNotReady
status: "False"
type: ContainersReady
- lastProbeTime: null
lastTransitionTime: "2021-06-28T17:58:28Z"
status: "True"
type: PodScheduled
containerStatuses:
- image: registry.redhat.io/redhat/redhat-operator-index:v4.6
imageID: ""
lastState: {}
name: registry-server
ready: false
restartCount: 0
started: false
state:
waiting:
message: Back-off pulling image "registry.redhat.io/redhat/redhat-operator-index:v4.6"
reason: ImagePullBackOff
hostIP: 192.168.126.11
phase: Pending
podIP: 10.217.0.42
podIPs:
- ip: 10.217.0.42
qosClass: Burstable
startTime: "2021-06-28T17:58:29Z"
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment