search

crc-org / crc-extension

Red Hat OpenShift Local Extension for integration of OpenShift Local clusters with Podman Desktop
Apache License 2.0
19 stars 21 forks source link

Consistent behavior with the Reboot required message #127

Open themr0c opened 1 year ago

themr0c commented 1 year ago

On Windows 10 Pro, Installing from Podman Desktop, I got this sequence:

  1. I uninstalled the previous version of OpenShift Local and did not reboot.

  2. I installed the latest version of Podman Desktop.

  3. I installed the latest version of the OpenShift Local extension.

  4. I installed OpenShift Local from Podman Destkop.

  5. Install finished. Reboot required message. OK button. I clicked OK. Screenshot from 2023-05-19 12:55:19 Selection 767x333 01

  6. Defender notification. Screenshot from 2023-05-19 12:56:07 Selection 762x429 01

  7. Preset choice. I clicked MicroShift. Screenshot from 2023-05-19 12:58:30 Selection 763x414 01

  8. Preset installation started immediately.

  9. The initialization failed. It is not possible to scroll the error message: Screenshot from 2023-05-19 13:30:22 Selection 1442x1641 01

The behavior should be more consistent with the "Reboot required" message: I didn't have a chance to reboot before the Preset choice screen, and when I selected a Preset the installation was not delayed.

Maybe running the initialization should be delayed until the reboot is done?

Maybe selecting the Preset and / or running the initialization should wait for the user pressing the button to start?

Maybe the OK button should be replaced with a "Reboot" button?

The tail of .crc\crc.log : 

time="2023-05-19T12:33:56+02:00" level=debug msg="CRC version: 2.18.0+4ea3a1\n"
time="2023-05-19T12:33:56+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:33:56+02:00" level=debug msg="Podman version: 4.4.1\n"
time="2023-05-19T12:33:56+02:00" level=debug msg="Running 'crc version'"
time="2023-05-19T12:33:57+02:00" level=warning msg="A new version (2.19.0) has been published on https://developers.redhat.com/content-gateway/file/pub/openshift-v4/clients/crc/2.19.0/crc-windows-installer.zip"
time="2023-05-19T12:33:57+02:00" level=debug msg="CRC version: 2.18.0+4ea3a1\n"
time="2023-05-19T12:33:57+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:33:57+02:00" level=debug msg="Podman version: 4.4.1\n"
time="2023-05-19T12:33:57+02:00" level=debug msg="Running 'crc setup'"
time="2023-05-19T12:33:57+02:00" level=info msg="Using bundle path C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.13_amd64.crcbundle"
time="2023-05-19T12:33:57+02:00" level=info msg="Checking if current user is in crc-users and Hyper-V admins group"
time="2023-05-19T12:33:57+02:00" level=debug msg="Running '(Get-LocalGroupMember -Group 'crc-users').Name'"
time="2023-05-19T12:33:59+02:00" level=debug msg="Checking current user is in the 'crc-user' group"
time="2023-05-19T12:33:59+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:33:59+02:00" level=debug msg="Running '(Get-LocalGroupMember -SID 'S-1-5-32-578').Name'"
time="2023-05-19T12:33:59+02:00" level=debug msg="Checking current user is in the 'Hyper-v Administrators' group"
time="2023-05-19T12:33:59+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:33:59+02:00" level=info msg="Checking if CRC bundle is extracted in '$HOME/.crc'"
time="2023-05-19T12:33:59+02:00" level=info msg="Checking if C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.13_amd64.crcbundle exists"
time="2023-05-19T12:33:59+02:00" level=debug msg="C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.13_amd64.crcbundle exists"
time="2023-05-19T12:33:59+02:00" level=info msg="Checking if the daemon task is installed"
time="2023-05-19T12:33:59+02:00" level=debug msg="Running 'Get-ScheduledTask -TaskName crcDaemon'"
time="2023-05-19T12:34:03+02:00" level=debug msg="Command failed: exit status 1"
time="2023-05-19T12:34:03+02:00" level=debug msg="stdout: "
time="2023-05-19T12:34:03+02:00" level=debug msg="stderr: Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T12:34:03+02:00" level=debug msg="crcDaemon task is not installed: exit status 1 : Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T12:34:03+02:00" level=debug msg="exit status 1"
time="2023-05-19T12:34:03+02:00" level=debug msg="CRC version: 2.18.0+4ea3a1\n"
time="2023-05-19T12:34:03+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:34:03+02:00" level=debug msg="Podman version: 4.4.1\n"
time="2023-05-19T12:34:03+02:00" level=debug msg="Running 'crc config get'"
time="2023-05-19T12:57:47+02:00" level=debug msg="CRC version: 2.19.0+a71226\n"
time="2023-05-19T12:57:47+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:57:47+02:00" level=debug msg="Podman version: 4.4.4\n"
time="2023-05-19T12:57:47+02:00" level=debug msg="Running 'crc version'"
time="2023-05-19T12:57:48+02:00" level=debug msg="No new version available. The latest version is 2.19.0"
time="2023-05-19T12:57:48+02:00" level=debug msg="CRC version: 2.19.0+a71226\n"
time="2023-05-19T12:57:48+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:57:48+02:00" level=debug msg="Podman version: 4.4.4\n"
time="2023-05-19T12:57:48+02:00" level=debug msg="Running 'crc setup'"
time="2023-05-19T12:57:48+02:00" level=info msg="Using bundle path C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T12:57:48+02:00" level=info msg="Checking minimum RAM requirements"
time="2023-05-19T12:57:48+02:00" level=debug msg="Total memory of system is 16776671232 bytes"
time="2023-05-19T12:57:48+02:00" level=info msg="Checking if current user is in crc-users and Hyper-V admins group"
time="2023-05-19T12:57:48+02:00" level=debug msg="Running '(Get-LocalGroupMember -Group 'crc-users').Name'"
time="2023-05-19T12:57:49+02:00" level=debug msg="Checking current user is in the 'crc-user' group"
time="2023-05-19T12:57:49+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:57:49+02:00" level=debug msg="Running '(Get-LocalGroupMember -SID 'S-1-5-32-578').Name'"
time="2023-05-19T12:57:50+02:00" level=debug msg="Checking current user is in the 'Hyper-v Administrators' group"
time="2023-05-19T12:57:50+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:57:50+02:00" level=info msg="Checking if CRC bundle is extracted in '$HOME/.crc'"
time="2023-05-19T12:57:50+02:00" level=info msg="Checking if C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle exists"
time="2023-05-19T12:57:50+02:00" level=debug msg="error getting bundle info for crc_microshift_hyperv_4.12.15_amd64.crcbundle: could not find cached bundle info in C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: CreateFile C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: The system cannot find the file specified."
time="2023-05-19T12:57:50+02:00" level=debug msg="could not find cached bundle info in C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: CreateFile C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: The system cannot find the file specified."
time="2023-05-19T12:59:45+02:00" level=debug msg="CRC version: 2.19.0+a71226\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="Podman version: 4.4.4\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="Running 'crc config set'"
time="2023-05-19T12:59:45+02:00" level=debug msg="Total memory of system is 16776671232 bytes"
time="2023-05-19T12:59:45+02:00" level=debug msg="CRC version: 2.19.0+a71226\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="OpenShift version: 4.12.13\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="Podman version: 4.4.4\n"
time="2023-05-19T12:59:45+02:00" level=debug msg="Running 'crc setup'"
time="2023-05-19T12:59:45+02:00" level=info msg="Using bundle path C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T12:59:45+02:00" level=info msg="Checking minimum RAM requirements"
time="2023-05-19T12:59:45+02:00" level=debug msg="Total memory of system is 16776671232 bytes"
time="2023-05-19T12:59:45+02:00" level=info msg="Checking if current user is in crc-users and Hyper-V admins group"
time="2023-05-19T12:59:45+02:00" level=debug msg="Running '(Get-LocalGroupMember -Group 'crc-users').Name'"
time="2023-05-19T12:59:46+02:00" level=debug msg="Checking current user is in the 'crc-user' group"
time="2023-05-19T12:59:46+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:59:46+02:00" level=debug msg="Running '(Get-LocalGroupMember -SID 'S-1-5-32-578').Name'"
time="2023-05-19T12:59:47+02:00" level=debug msg="Checking current user is in the 'Hyper-v Administrators' group"
time="2023-05-19T12:59:47+02:00" level=debug msg="group members: WIN10PRO\\Fabrice"
time="2023-05-19T12:59:47+02:00" level=info msg="Checking if CRC bundle is extracted in '$HOME/.crc'"
time="2023-05-19T12:59:47+02:00" level=info msg="Checking if C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle exists"
time="2023-05-19T12:59:47+02:00" level=debug msg="error getting bundle info for crc_microshift_hyperv_4.12.15_amd64.crcbundle: could not find cached bundle info in C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: CreateFile C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: The system cannot find the file specified."
time="2023-05-19T12:59:47+02:00" level=debug msg="could not find cached bundle info in C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: CreateFile C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64: The system cannot find the file specified."
time="2023-05-19T12:59:47+02:00" level=info msg="Getting bundle for the CRC executable"
time="2023-05-19T12:59:47+02:00" level=debug msg="Ensuring directory C:\\Users\\Fabrice\\.crc\\cache exists"
time="2023-05-19T12:59:47+02:00" level=debug msg="Got bundle path: C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T12:59:47+02:00" level=info msg="Downloading bundle: C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle..."
time="2023-05-19T12:59:48+02:00" level=debug msg="Got valid signature from key id: 199E2F91FD431D51"
time="2023-05-19T12:59:48+02:00" level=debug msg="Verified bundle hashes:\n13bf211f873ca6d95fbf181a642ad6d358383052101af11c7430012c5000ea82  crc_microshift_hyperv_4.12.15_amd64.crcbundle\nab9e71de9958afc6499e81b3cde7d13e225ea90564a50ad6060a13d54bd5000e  crc_microshift_libvirt_4.12.15_amd64.crcbundle\neacdcee59e3aa3b022f4f0875b62a426a84025487b01cb0c1d210b146b9181a8  crc_microshift_vfkit_4.12.15_amd64.crcbundle\nc738dca02ddd693d9bea7e21878007ceca5c16f63a4af22d3478ad4207c03cf3  crc_microshift_vfkit_4.12.15_arm64.crcbundle"
time="2023-05-19T12:59:48+02:00" level=debug msg="Downloading https://mirror.openshift.com/pub/openshift-v4/clients/crc/bundles/microshift/4.12.15/crc_microshift_hyperv_4.12.15_amd64.crcbundle to C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T13:05:14+02:00" level=debug msg="Download saved to C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T13:05:14+02:00" level=info msg="Uncompressing C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle"
time="2023-05-19T13:05:14+02:00" level=debug msg="Uncompressing C:\\Users\\Fabrice\\.crc\\cache\\crc_microshift_hyperv_4.12.15_amd64.crcbundle to C:\\Users\\Fabrice\\.crc\\cache\\tmp-extract"
time="2023-05-19T13:11:52+02:00" level=debug msg="retry loop: attempt 0"
time="2023-05-19T13:11:52+02:00" level=info msg="Checking if the daemon task is installed"
time="2023-05-19T13:11:52+02:00" level=debug msg="Running 'Get-ScheduledTask -TaskName crcDaemon'"
time="2023-05-19T13:11:55+02:00" level=debug msg="Command failed: exit status 1"
time="2023-05-19T13:11:55+02:00" level=debug msg="stdout: "
time="2023-05-19T13:11:55+02:00" level=debug msg="stderr: Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T13:11:55+02:00" level=debug msg="crcDaemon task is not installed: exit status 1 : Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T13:11:55+02:00" level=debug msg="exit status 1"
time="2023-05-19T13:11:55+02:00" level=info msg="Installing the daemon task"
time="2023-05-19T13:11:55+02:00" level=debug msg="Running 'Get-ScheduledTask -TaskName crcDaemon'"
time="2023-05-19T13:11:58+02:00" level=debug msg="Command failed: exit status 1"
time="2023-05-19T13:11:58+02:00" level=debug msg="stdout: "
time="2023-05-19T13:11:58+02:00" level=debug msg="stderr: Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T13:11:58+02:00" level=debug msg="crcDaemon task is not installed: exit status 1 : Get-ScheduledTask : No MSFT_ScheduledTask objects found with property 'TaskName' equal to 'crcDaemon'.  Verify the \r\nvalue of the property and retry.\r\nAt line:1 char:43\r\n+ ... reference = 'SilentlyContinue'; Get-ScheduledTask -TaskName crcDaemon\r\n+                                     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n    + CategoryInfo          : ObjectNotFound: (crcDaemon:String) [Get-ScheduledTask], CimJobException\r\n    + FullyQualifiedErrorId : CmdletizationQuery_NotFound_TaskName,Get-ScheduledTask\r\n \r\n"
time="2023-05-19T13:11:58+02:00" level=debug msg="Running 'Register-ScheduledTask -Xml '<?xml version=\"1.0\" encoding=\"UTF-16\"?>\n<Task version=\"1.3\" xmlns=\"http://schemas.microsoft.com/windows/2004/02/mit/task\">\n  <RegistrationInfo>\n    <Description>Run crc daemon as a task</Description>\n    <Version>2.19.0</Version>\n  </RegistrationInfo>\n  <Settings>\n    <DisallowStartIfOnBatteries>false</DisallowStartIfOnBatteries>\n    <StopIfGoingOnBatteries>false</StopIfGoingOnBatteries>\n    <Hidden>true</Hidden>\n    <MultipleInstancesPolicy>IgnoreNew</MultipleInstancesPolicy>\n    <IdleSettings>\n      <Duration>PT10M</Duration>\n      <WaitTimeout>PT1H</WaitTimeout>\n      <StopOnIdleEnd>true</StopOnIdleEnd>\n      <RestartOnIdle>false</RestartOnIdle>\n    </IdleSettings>\n    <UseUnifiedSchedulingEngine>true</UseUnifiedSchedulingEngine>\n  </Settings>\n  <Triggers>\n    <LogonTrigger>\n      <UserId>WIN10PRO\\Fabrice</UserId>\n    </LogonTrigger>\n  </Triggers>\n  <Actions Context=\"Author\">\n    <Exec>\n      <Command>powershell.exe</Command>\n      <Arguments>-WindowStyle Hidden -Command &amp; &#39;c:\\Program Files\\Red Hat OpenShift Local\\crc.exe&#39; daemon</Arguments>\n    </Exec>\n  </Actions>\n</Task>\n' -TaskName crcDaemon'"
time="2023-05-19T13:12:00+02:00" level=info msg="Checking if the daemon task is running"
time="2023-05-19T13:12:00+02:00" level=debug msg="Running '(Get-ScheduledTask -TaskName \"crcDaemon\").State'"
time="2023-05-19T13:12:03+02:00" level=debug msg="expected crcDaemon task to be in 'Running' but got 'Ready\r\n'"
time="2023-05-19T13:12:03+02:00" level=info msg="Running the daemon task"
time="2023-05-19T13:12:03+02:00" level=debug msg="Running 'Start-ScheduledTask -TaskName crcDaemon'"
time="2023-05-19T13:12:05+02:00" level=debug msg="retry loop: attempt 0"
time="2023-05-19T13:12:05+02:00" level=debug msg="error: Temporary error: daemon is not running yet - sleeping 2s"
time="2023-05-19T13:12:07+02:00" level=debug msg="retry loop: attempt 1"
time="2023-05-19T13:12:07+02:00" level=info msg="Checking admin helper service is running"
time="2023-05-19T13:12:07+02:00" level=debug msg="Running '(Get-Service crcAdminHelper).Status'"
time="2023-05-19T13:12:07+02:00" level=debug msg="Get \"http://unix/version\": open \\\\.\\pipe\\crc-admin-helper: Access is denied."
deboer-tim commented 1 year ago

Maybe the OK button should be replaced with a "Reboot" button?

Just a nit: we shouldn't have a dialog where the only button is 'reboot'. Ok if the default button is reboot but there is a cancel or 'I'll do it later' button.

themr0c commented 1 year ago

Note that I didn't reboot and I can see this service running: Screenshot from 2023-05-19 13:50:47 Selection 1198x44 01

themr0c commented 1 year ago

The message, if I reboot after uninstalling OpenShift Local, is different. I get:

Screenshot from 2023-05-19 14:13:59 Selection 1455x979 01

odockal commented 1 year ago

I would like to emphasize this issue. It is an inevitable error for the user when starting with CRC which can be fixed by change in the workflow. I have yet encountered it.