Failed to register with PSC - OVA 1.5.8

[gitloy]

Summary

Installation failed: Failed to register with PSC. Please check the PSC settings provided and try again

Environment information

vSphere and vCenter Server version

vSphere: VMware ESXi, 6.7.0, 15160138
vCenter: Server 6.7.0.48000

VIC Appliance version

vic-v1.5.8-7942-4cc5e276.ova

Configuration

• EmbeddedPSC:
• How was the OVA deployed? HTML5
• Does the VIC appliance receive configuration by DHCP? Yes
• What [stage of the Appliance Lifecycle][1] is the VIC appliance in? OVA is deployed, configuration step not completing
• IP address of VIC appliance:
• Hostname of VIC appliance: vcntr-01-wat.ourmagnet.net
• IP address of vCenter Server:
• Hostname of vCenter Server: vIntCont-01-wat

Details

When working through the Complete VIC appliance installation step I end up with the following error. All default options were used for the set up of the appliance.

Error: "Installation failed: Failed to register with PSC. Please check the PSC settings provided and try again"

Steps to reproduce

This occurs each time I enter the necessary details

Logs

Below I believe is the relevant log detail

The lines that stick out for me contain

Error running PSC register command for harbor
Failed to load class "org.slf4j.impl.StaticLoggerBinder

Jan 19 15:40:24 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:24.348Z INFO op=1762.32: PSC Out of the box users. CreateUsers: True, FoundCreateUsers: true, Prefix
: vic

Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.823Z INFO op=1762.32: Error running PSC register command for harbor: [0][I][2022-01-19T15:40:24.5
38Z][1][SsoPscCommand][register][Initializing...]

Jan 19 15:40:26 localhost start_fileserver.sh[1759]: [1][I][2022-01-19T15:40:24.546Z][1][SsoPscCommand][register][Registering...]
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: [2][I][2022-01-19T15:40:24.570Z][1][SsoPscCommand][deleteFile][Removal of file: '/etc/vmware/psc/harbor/psc-config.keys
tore' result: true]

Jan 19 15:40:26 localhost start_fileserver.sh[1759]: SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".

Jan 19 15:40:26 localhost start_fileserver.sh[1759]: SLF4J: Defaulting to no-operation (NOP) logger implementation
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Exception in thread "main" com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientException: General SSO failure.
Invalid host, port or tenant.
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientFactoryImpl.createSSOAdminClient(SsoAdminClient
FactoryImpl.java:148)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminFacade.registerOrRetrieveSolutionUser(SsoAdminFacade.
java:172)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.saml.util.SsoPscCommand.register(SsoPscCommand.java:83)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.util.PscCommand.execute(PscCommand.java:43)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.util.PscCommand.main(PscCommand.java:56)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Caused by: com.vmware.vim.sso.admin.exception.InternalError: General failure.
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.VmomiClientCommand.execute(VmomiClientCommand.java:211)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.VmomiClientCommand.executeEnsuringNoDomainError(VmomiClientComman
d.java:217)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.AdminClientImpl.createServiceContent(AdminClientImpl.java:341)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.AdminClientImpl.(AdminClientImpl.java:107)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.VmomiClientFactory.createAdminClient(VmomiClientFactory.java:64)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.VmomiClientFactory.createAdminClient(VmomiClientFactory.java:54)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientFactoryImpl.createSSOAdminClient(SsoAdminClient
FactoryImpl.java:123)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: ... 4 more
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Caused by: com.vmware.vim.vmomi.client.common.UnexpectedStatusCodeException: Unexpected status code: 404
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.Response$Status.getStatus(Response.java:58)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.http.impl.HttpExchangeBase.parseResponse(HttpExchangeBase.java:150)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.http.impl.HttpExchange.run(HttpExchange.java:48)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.http.impl.HttpProtocolBindingBase.executeRunnable(HttpProtocolBindingBase.java:2
26)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.http.impl.HttpProtocolBindingImpl.send(HttpProtocolBindingImpl.java:110)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.impl.MethodInvocationHandlerImpl$CallExecutor.sendCall(MethodInvocationHa
ndlerImpl.java:613)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.impl.MethodInvocationHandlerImpl$CallExecutor.executeCall(MethodInvocatio
nHandlerImpl.java:594)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.impl.MethodInvocationHandlerImpl.completeCall(MethodInvocationHandlerImpl
.java:345)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.impl.MethodInvocationHandlerImpl.invokeOperation(MethodInvocationHandlerI
mpl.java:305)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.vmomi.client.common.impl.MethodInvocationHandlerImpl.invoke(MethodInvocationHandlerImpl.java:
179)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.sun.proxy.$Proxy24.retrieveServiceContent(Unknown Source)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.AdminClientImpl$1.actionCommand(AdminClientImpl.java:339)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.AdminClientImpl$1.actionCommand(AdminClientImpl.java:334)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: at com.vmware.vim.sso.admin.client.vmomi.impl.VmomiClientCommand.execute(VmomiClientCommand.java:103)
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: ... 10 more
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.826Z DEBUG op=1762.32: exit status 1
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.831Z ERROR op=1762.32: Install failed: Failed to register with PSC. Please check the PSC settings
provided and try again
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.831Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.RenderTemplate:45]
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.831Z INFO op=1762.32: render: html/index.html
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.834Z DEBUG [ END ] [vic-product/installer/fileserver/routes.RenderTemplate:45] [3.171027ms]
Jan 19 15:40:26 localhost start_fileserver.sh[1759]: Jan 19 2022 15:40:26.834Z DEBUG [ END ] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52]

Troubleshooting attempted

I have tried using both the FQDN and IP address for our vcenter with embedded PSC. My admin account is the only one which allows me to get this far in the configuration process. Using the root account for vcenter returns invalid credentials, but they do work with the vcenter:5480 management console.

[gitloy]

I will add that I can ssh into the appliance and from there I can successfully ping both the FQDN and IP address of our vcenter/psc

And the time between the VMs is within a second or so.

[AlchemicalChef]

I'm having the same issue here as well, none of the previous troubleshooting steps have worked.

I think we're on our own, VIC is EOL

This is my error log.

Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.247Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.247Z DEBUG op=1759.19: [NewOperation] op=1759.19 [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:53]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.247Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.RenderTemplate:45]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.247Z INFO op=1759.19: render: html/index.html
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.249Z DEBUG [ END ] [vic-product/installer/fileserver/routes.RenderTemplate:45] [2.313119ms]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.249Z DEBUG [ END ] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52] [2.615171ms]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.407Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.407Z DEBUG op=1759.20: [NewOperation] op=1759.20 [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:53]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.407Z ERROR op=1759.20: Request path /favicon.ico not found in map[/:{} /index.html:{}]
Jan 25 10:38:08 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:08.407Z DEBUG [ END ] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52] [182.385µs]
Jan 25 10:38:26 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:26.468Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.ThumbprintHandler:33]
Jan 25 10:38:26 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:26.468Z DEBUG op=1759.21: [NewOperation] op=1759.21 [vic-product/installer/fileserver/routes.ThumbprintHandler:37]
Jan 25 10:38:26 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:26.503Z INFO op=1759.21: Thumbprint found
Jan 25 10:38:26 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:26.503Z DEBUG [ END ] [vic-product/installer/fileserver/routes.ThumbprintHandler:33] [34.42371ms]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.191Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.191Z DEBUG op=1759.22: [NewOperation] op=1759.22 [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:53]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.246Z DEBUG [BEGIN] [vic-product/installer/lib.(*LoginInfo).VerifyLogin:43]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.246Z INFO op=1759.22: server URL: vcenter.lysanthyia.com
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.246Z DEBUG op=1759.22: Creating VMOMI session with thumbprint 80:B4:53:8A:80:14:9C:E6:85:96:12:12:5A:36:89:C3:E1:D5:45:34
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.309Z DEBUG Session Environment Info:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.309Z DEBUG op=1759.22: vSphere resource cache populating...
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.313Z DEBUG op=1759.22: Cached dc:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.319Z DEBUG op=1759.22: Cached cluster:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.334Z DEBUG op=1759.22: Cached host:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.343Z DEBUG op=1759.22: Cached pool:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.346Z DEBUG op=1759.22: Cached folders:
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.346Z DEBUG op=1759.22: Error count populating vSphere cache: (1)
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.346Z DEBUG [ END ] [vic-product/installer/lib.(*LoginInfo).VerifyLogin:43] [99.47539ms]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.346Z INFO op=1759.22: Validation succeeded
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.692Z DEBUG op=1759.22: successfully attached the product tag
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.695Z INFO op=1759.22: vCenter user: [email protected]
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.695Z INFO op=1759.22: PSC instance: vcenter.lysanthyia.com
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.695Z INFO op=1759.22: PSC domain: vsphere.local
Jan 25 10:38:31 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:31.696Z INFO op=1759.22: PSC Out of the box users. CreateUsers: False, FoundCreateUsers: true, Prefix: vic
Jan 25 10:38:31 localhost wait_for_file.sh[167]: File /etc/vmware/psc/admiral/psc-config.properties does not yet exist. sleeping 30 seconds...
Jan 25 10:38:31 localhost dbus-daemon[170]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.18' (uid=0 pid=2053 comm="hostnamectl status --static ")
Jan 25 10:38:31 localhost systemd[1]: Starting Hostname Service...
Jan 25 10:38:31 localhost dbus-daemon[170]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jan 25 10:38:31 localhost systemd[1]: Started Hostname Service.
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.690Z INFO op=1759.22: Error running PSC register command for harbor: [0][I][2022-01-25T10:38:31.877Z][1][SsoPscCommand][register][Initializing...]
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: [1][I][2022-01-25T10:38:31.883Z][1][SsoPscCommand][register][Registering...]
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: [2][I][2022-01-25T10:38:31.902Z][1][SsoPscCommand][deleteFile][Removal of file: '/etc/vmware/psc/harbor/psc-config.keystore' result: true]
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: SLF4J: Defaulting to no-operation (NOP) logger implementation
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Exception in thread "main" com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientException: Server returned 'request expired' less than 0 seconds after request was issued, but it shouldn't have expired for at least 600 seconds.
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientFactoryImpl.createSSOAdminClient(SsoAdminClientFactoryImpl.java:156)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminFacade.registerOrRetrieveSolutionUser(SsoAdminFacade.java:172)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.saml.util.SsoPscCommand.register(SsoPscCommand.java:83)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.util.PscCommand.execute(PscCommand.java:43)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.util.PscCommand.main(PscCommand.java:56)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Caused by: com.vmware.vim.sso.client.exception.TimeSynchronizationException: Server returned 'request expired' less than 0 seconds after request was issued, but it shouldn't have expired for at least 600 seconds.
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.vim.sso.client.impl.SecurityTokenServiceImpl$RequestResponseProcessor.checkTimeSyncronization(SecurityTokenServiceImpl.java:902)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.vim.sso.client.impl.SecurityTokenServiceImpl$RequestResponseProcessor.executeRoundtrip(SecurityTokenServiceImpl.java:858)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.vim.sso.client.impl.SecurityTokenServiceImpl.acquireToken(SecurityTokenServiceImpl.java:149)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: at com.vmware.admiral.auth.idm.psc.saml.sso.admin.SsoAdminClientFactoryImpl.createSSOAdminClient(SsoAdminClientFactoryImpl.java:140)
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: ... 4 more
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.692Z DEBUG op=1759.22: exit status 1
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.696Z ERROR op=1759.22: Install failed: Failed to register with PSC. Please check the PSC settings provided and try again
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.696Z DEBUG [BEGIN] [vic-product/installer/fileserver/routes.RenderTemplate:45]
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.696Z INFO op=1759.22: render: html/index.html
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.697Z DEBUG [ END ] [vic-product/installer/fileserver/routes.RenderTemplate:45] [857.124µs]
Jan 25 10:38:33 localhost start_fileserver.sh[1758]: Jan 25 2022 10:38:33.697Z DEBUG [ END ] [vic-product/installer/fileserver/routes.(*IndexHTMLRenderer).IndexHandler:52] [2.505682144s]
Jan 25 10:39:01 localhost wait_for_file.sh[167]: File /etc/vmware/psc/admiral/psc-config.properties does not yet exist. sleeping 30 seconds...

[gitloy]

@AlchemicalChef From what I've seen on the vmware subreddit I'm pretty sure no one is working this project anymore.

[AlchemicalChef]

Yeah they want you to use Tanzu instead, but it's way more effort than I want to put in.

[lazarin]

Seems like both error logs reveal different problems,
@AlchemicalChef can you try to sync the clock on all machines, probably there's some time lag between them
@gitloy not sure in that case, just seeing that there's Unexpected status code: 404 in library which is trying to connect to the psc :(