$ $ $ $ $ $tail -f FWSTrace.log [03/25/2021][17:47:13][15243][139664325392128][][agentcommon][][The Configuration Management thread is calling doManagement()] [03/25/2021][17:47:13][15243][139664325392128][][agentcommon][][There are doManagement messages] [03/25/2021][17:47:43][15243][139664325392128][][agentcommon][][The Configuration Management thread is calling doManagement()] [03/25/2021][17:47:43][15243][139664325392128][][agentcommon][][There are doManagement messages] [03/25/2021][17:48:12][15243][139664324339456][][CustomPostPageCache][performUpdate][Checking for updates] [03/25/2021][17:48:12][15243][139664324339456][][CustomPostPageCache][performUpdate][No custom pages cached.] [03/25/2021][17:48:13][15243][139664325392128][][agentcommon][][The Configuration Management thread is calling doManagement()] [03/25/2021][17:48:13][15243][139664325392128][][agentcommon][][There are doManagement messages] [03/25/2021][17:48:43][15243][139664325392128][][agentcommon][][The Configuration Management thread is calling doManagement()] [03/25/2021][17:48:43][15243][139664325392128][][agentcommon][][There are doManagement messages] [03/25/2021][17:49:09][15243][139664254768896][][agentcommon][][Requesting data for ConfigManager ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf] [03/25/2021][17:49:09][15243][139664254768896][][agentcommon][][Administration Manager is returning data for ConfigManager ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][doGet][SAML2 Single Sign-On Service received GET request.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][doRequestLog][Requesting Host: 10.22.198.17 Requesting Host IP: 10.22.198.17 Request protocol: HTTP/1.1 Request was secure: false Authentication type: null] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][doGet][Query String: SPID=sp_healthequity-regence] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][getSavedRequestDataUsingGuid][Enter getSavedRequestDataUsingGuid] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: tealiumid] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: tealiumsesid] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: AMCVS_3C4035EB5A8D34DB0A495C3C%40AdobeOrg] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: AMCV_3C4035EB5A8D34DB0A495C3C%40AdobeOrg] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: SMSESSION] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: SSO_SESSIONID] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: SSO_SESSIONID.sig] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: utag_main] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: previous_page_name_ck] [03/25/2021][17:49:09][15243][139664254768896][][DelegatedAuthHelper][getCookie][Cookie Name: mp_170b55be21b007824cf83bec55300cb1_mixpanel] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][doGet][Request is UNSOLICITED!] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][getDisambiguationID][Retrieving the disambiguation ID from the requested URI /affwebservices/public/saml2sso] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][getDisambiguationID][serviceURL=/public/saml2sso/] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][getDisambiguationID][serviceURL /public/saml2sso/ not found in requestedURI /affwebservices/public/saml2sso] [03/25/2021][17:49:09][15243][139664254768896][][agentcommon][][Requesting data for ConfigManager ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf] [03/25/2021][17:49:09][15243][139664254768896][][agentcommon][][Administration Manager is returning data for ConfigManager ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /usr/pservices/ca/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Reading SAML 2.0 SP Configuration [CHECKPOINT = SSOSAML2_SPCONFREAD_REQ]] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SAML2Base.java][getServiceProviderInfo][Trying to fetch SAML2.0 SP Configuration from cache [CHECKPOINT = SAML2_SPCONFFROMCACHE_REQ]] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SAML2Base.java][getServiceProviderInfo][Obtained service provider information from cache for: sp_healthequity-regence.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SAML2Base.java][getServiceProviderInfo][Obtained service provider information from cache for: sp_healthequity-regence.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][ProviderID: sp_healthequity-regence] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][IsPassive: false] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][ForceAuthn: false] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][isSetAssertionConsumerServiceIndex: false] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][AssertionConsumerServiceIndex: 0] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][RelayState: null] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][authResult: null] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Changing the default binding to Post as no binding is specified in query parameters ] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Unable to get Assertion Consumer URL. Verifying for Default Assertion Consumer URL in config] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][validateDynamicAuthentication][Dynamic Authentication is not configured] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][AffiliateName: healthequity - regence.com] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][RealmOID: 06-00008794-e576-17b4-a474-87f40a16a0be] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Request to validate the session [CHECKPOINT = SSOSAML2_SESSIONCOOKIEVALIDATE_REQ]] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isValidSession][Checking for valid SESSION cookies.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][getSessionData][session cookie name: SMSESSION] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isValidSession][Found SESSION cookie: SMSESSION] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isSessionIdle][Verifying validity of session cookie [SMSESSION] retrieved] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isSessionIdle][Request doesn't contain session ID header. Session cookie[SMSESSION]is not valid.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isSessionIdle][returning true] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][FWSBase.java][isValidSession][Session is Idle] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Force Authn is disabled.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Current session state is: false] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Current session is not a valid session.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processRequest][Session cookie does not exists. redirecting to authentication url [CHECKPOINT = SSOSAML2_AUTHENTICATIONURL_REDIRECT]] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][getLocalServiceURL][Enter getLocalServiceURL] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][getLocalServiceURL][Using Proxy URL for local SSO service: https://fedsvc-staging.regence.com/affwebservices/public/saml2sso] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processAuthentication][Not using secure authentication URL.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processAuthentication][SAMLTransactionID 2ad788b0-c0e20621-0e641182-47a80040-889f0b76-3c maps to TransactionID: 182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b.] [03/25/2021][17:49:09][15243][139664254768896][182a0e4f-792d5f4d-fa0f231f-f6c02d22-0d41aa70-0b][SSO.java][processAuthentication][SAML2 Single Sign-On Service redirecting to authentication URL: https://fedsvc-staging.regence.com/affwebservices/redirectjsp/smportalstate_regence.jsp?SPID=sp_healthequity-regence&SMPORTALURL=https%3A%2F%2Ffedsvc-staging.regence.com%2Faffwebservices%2Fpublic%2Fsaml2sso&SAMLTRANSACTIONID=2ad788b0-c0e20621-0e641182-47a80040-889f0b76-3c.] [03/25/2021][17:49:12][15243][139664324339456][][CustomPostPageCache][performUpdate][Checking for updates] [03/25/2021][17:49:12][15243][139664324339456][][CustomPostPageCache][performUpdate][No custom pages cached.] [03/25/2021][17:49:13][15243][139664325392128][][agentcommon][][The Configuration Management thread is calling doManagement()] [03/25/2021][17:49:13][15243][139664325392128][][agentcommon][][There are doManagement messages] ^C $