Any idea on this SLO issue ?
[12/20/2019][00:41:36][24892][139758777112320][][SLOService.java][doInitLog][------------------------------------------------]
[12/20/2019][00:41:36][24892][139758777112320][][SLOService.java][doInitLog][SAML2 Single Logout Service Initialization.]
[12/20/2019][00:41:36][24892][139758777112320][][SLOService.java][doInitLog][------------------------------------------------]
[12/20/2019][00:41:36][24892][139758777112320][][FWSBase.java][init][Fips140Mode = 1]
[12/20/2019][00:41:36][24892][139758777112320][][SLOService.java][init][SAML2 Single Logout Service has been successfully initialized.]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Requesting data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Administration Manager is returning data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Requesting data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Administration Manager is returning data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][FWSBase.java][getSLOGUIDCookie][Entering [configurationContextData: com.netegrity.siteminder.agentcommon.framework.d@19ba307b]]
[12/20/2019][00:41:36][24892][139758777112320][][FWSBase.java][getSLOGUIDCookie][Leaving [guid: d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b]]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Requesting data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Administration Manager is returning data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][doPost][Receiving request at SAML2 SLO Logout URL through POST method [CHECKPOINT = SLOSAML2_LOGOUTSERVICEPOST_RECEIVE]]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][doPost][SAML2 Single Logout Service received POST request.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][doRequestLog][Requesting Host: 10.121.89.131 Requesting Host IP: 10.121.89.131 Request protocol: HTTP/1.1 Request was secure: true Authentication type: null]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][canDoSOAP][Request is NOT SOAP: /affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][doPostImpl][ENTER:doPostImpl]
[12/20/2019][00:41:36][24892][139758777112320][][SLOService.java][validateRequest][Validate GET request for necessary parameters [CHECKPOINT = SLOSAML2_GETREQUEST_VALIDATE]]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][doPostImpl][SAML message received=<?xml version="1.0" encoding="UTF-8"?><saml2p:LogoutRequest xmlns:saml2p="urn:oasis:names:tc:SAML:2.0:protocol" Destination="https://sit.auth.optus.com.au/affwebservices/public/saml2slo" ID="a585ig4j65iab1h447h4d9ge61fgi11" IssueInstant="2019-12-20T00:41:37.995Z" Version="2.0"><saml2:Issuer xmlns:saml2="urn:oasis:names:tc:SAML:2.0:assertion">ogqganefubgfipj-xj3atxs4pncp1hlw.apigee-saml-login</saml2:Issuer><ds:Signature xmlns:ds="http://www.w3.org/2000/09/xmldsig#"><ds:SignedInfo><ds:CanonicalizationMethod Algorithm="http://www.w3.org/2001/10/xml-exc-c14n#"/><ds:SignatureMethod Algorithm="http://www.w3.org/2001/04/xmldsig-more#rsa-sha256"/><ds:Reference URI="#a585ig4j65iab1h447h4d9ge61fgi11"><ds:Transforms><ds:Transform Algorithm="http://www.w3.org/2000/09/xmldsig#enveloped-signature"/><ds:Transform Algorithm="http://www.w3.org/2001/10/xml-exc-c14n#"/></ds:Transforms><ds:DigestMethod Algorithm="http://www.w3.org/2001/04/xmlenc#sha256"/><ds:DigestValue>N5hl5YjvLyrX5QbbiLA32H+bTlD4fW/SrtMdXCEelLc=</ds:DigestValue></ds:Reference></ds:SignedInfo><ds:SignatureValue>dazMyG6d59iHmv6gU72SQWqnhFskGRCIryo0d9XYZOAIDb1DjM1kMoi/igGllHldNr/d2rO3jpExXeQUlZ0El/2gJCRA/KrxlsYWOYWg6KxRoq811LH5+9sxS+vtzRnHJmtYveLBoxq1o/NObY9akcHsCTNmLKw0XDNhaAWDej30wMl3jzKwgZwAC5RohJghuReNP7X/38MyBylBEAI8lLQE8TRSyDRpJNf8thAqql0aXGG2mvcXuvaR9IcZxOtjvnRQucvtClZzD3QjqQoqNoerJMSm4YvFuHGhtA9W15WNS1JWAUjuVGRje3ofc8/0h/Lp1072hTQCZJBfAuF+Mg==</ds:SignatureValue><ds:KeyInfo><ds:X509Data><ds:X509Certificate>MIIFozCCBIugAwIBAgIRAKG9zQebVRRBAQAAAAAaw0swDQYJKoZIhvcNAQELBQAwQjELMAkGA1UE
BhMCVVMxHjAcBgNVBAoTFUdvb2dsZSBUcnVzdCBTZXJ2aWNlczETMBEGA1UEAxMKR1RTIENBIDFP
MTAeFw0xOTAxMTQxNzQ2NTVaFw0yMDAxMTMxNzQ2NTVaMGoxCzAJBgNVBAYTAlVTMRMwEQYDVQQI
EwpDYWxpZm9ybmlhMRYwFAYDVQQHEw1Nb3VudGFpbiBWaWV3MRMwEQYDVQQKEwpHb29nbGUgTExD
MRkwFwYDVQQDExBsb2dpbi5hcGlnZWUuY29tMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKC
AQEAynAEiaNMvscrrw5/dbQdIHsjX6gNCRNe7HWDWspX5su46hk6KGaEX8sYWmHLR5SqTyQpVZ/4
8GDyk2P5NJNOCzNyJDL+on/ZQ2GA5Pu0Jsq0XcOIGbHWJ7JX2elT3DQ7Cf3zhreLzaUKcnFEat8z
3dufY/qOblRj9tZ7Q8DwPE3W9ElQOlKDOMl9q+iIxge/W85Bu1nWTjWqEUlmP0np9HplCJ471y6y
snOxXCZRyqOSx6+bCAXyFL1jQ434LkmIH6snjTfEuYt816aQuCinIgDyCvgtccmmiHCywGZhD6mP
45oUSdPRqySy42FkC09wa68/urttvD6pWfAnAhTUnwIDAQABo4ICajCCAmYwDgYDVR0PAQH/BAQD
AgWgMBMGA1UdJQQMMAoGCCsGAQUFBwMBMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFAl422hm60W2
sj41v7T9ryc1JzNvMB8GA1UdIwQYMBaAFJjR+G4Q68+b7GCfGJAboOt9Cf0rMGQGCCsGAQUFBwEB
BFgwVjAnBggrBgEFBQcwAYYbaHR0cDovL29jc3AucGtpLmdvb2cvZ3RzMW8xMCsGCCsGAQUFBzAC
hh9odHRwOi8vcGtpLmdvb2cvZ3NyMi9HVFMxTzEuY3J0MC8GA1UdEQQoMCaCEGxvZ2luLmFwaWdl
ZS5jb22CEioubG9naW4uYXBpZ2VlLmNvbTAhBgNVHSAEGjAYMAgGBmeBDAECAjAMBgorBgEEAdZ5
AgUDMC8GA1UdHwQoMCYwJKAioCCGHmh0dHA6Ly9jcmwucGtpLmdvb2cvR1RTMU8xLmNybDCCAQQG
CisGAQQB1nkCBAIEgfUEgfIA8AB1ALIeBcyLos2KIE6HZvkruYolIGdr2vpw57JJUy3vi5BeAAAB
aE2wJd4AAAQDAEYwRAIgE5qO0j6O+mnFgQT5QV2005gT/z4Y9SwIFiJWyilYf+YCIBBwZ2ZvbWj8
6EOLiwLhQvxV7o47q5TidaespugrwbCUAHcAXqdz+d9WwOe1Nkh90EngMnqRmgyEoRIShBh1loFx
RVgAAAFoTbAl/gAABAMASDBGAiEAuUcc2S29sxMRcifJdHtls/zviIBlD7GNJJES7W3FzssCIQD9
s1OqoMG5s9hD/OFOiNgLVg1Ga+Qvk+n4IRqAs00cdjANBgkqhkiG9w0BAQsFAAOCAQEAF2FfC4Gv
4ialJOZZTZXk/hlXWJS8DZhxMLXT/cAzaJjtX64Ps2qY4xNSkuEmszVkwW4KdhKR1u+RGW6PRons
0fC8rI4P1V6Ov6fq1WUeW2rQETzv+8riTbE9rvnKy2+0xscWvoEyGRK060TrMDFFHY5LI/jVCAIM
bW1w1Tbopatc7dhWHbRtUUrTChOAS3AnGorXOsucoMzMW7aRxfmMg6HwRPA5jJyPU92wZJLLd3Py
wLmvEQ3RzxCOoKtbZRM5XXZUmi6ptnyxV73hYjbPSpuv1UCT9AMmSnfrwi7bozz7/DzD9Kv8WES5
GYUVaiD+1B4OZ8dT/qJ1VrA5ABiwVQ==</ds:X509Certificate></ds:X509Data></ds:KeyInfo></ds:Signature><saml2:NameID xmlns:saml2="urn:oasis:names:tc:SAML:2.0:assertion" Format="urn:oasis:names:tc:SAML:1.1:nameid-format:unspecified">Internal</saml2:NameID><saml2p:SessionIndex>3fRK+ULeWIAeZbTBw26RQQunS5E=/Gppmg==</saml2p:SessionIndex></saml2p:LogoutRequest]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][doPostImpl][Relay State received={"redirect":"https://optus-enterprise-nonprod-optusinternal.apigee.io/logout","client_id":"portal-bnj0eaxbar"}]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Requesting data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Administration Manager is returning data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][RequestID: 251edc48-fb2416dd-00be157e-320dfa47-b19bc641-f5c]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][RequestID 251edc48-fb2416dd-00be157e-320dfa47-b19bc641-f5c maps to TransactionID: d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getSessionFromCookie][Fetching session details from cookie [CHECKPOINT = SLO_SESSION_FETCH]]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getSessionCookie][currentZone + Session cookie suffix: SMSESSION]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getSessionCookie][SESSIONSIGNOUT Cookie found.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][validateSessionData][Transaction with ID: d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b failed. Reason: FWSB_INVALID_SMSESSION]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][validateSessionData][The SESSION cookie is expired or invlaid. Global Logout can not be performed.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][Warning: Length of Relay state {"redirect":"https://optus-enterprise-nonprod-optusinternal.apigee.io/logout","client_id":"portal-bnj0eaxbar"} is greater than 80 characters.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][Performing tunnel call for SAML1 SLO [CHECKPOINT = SLOSAML2_TUNNEL_REQUEST]]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][Retrieving the disambiguation ID from the requested URI /affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][serviceURL=/public/saml2slo/]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][serviceURL /public/saml2slo/ not found in requestedURI /affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][Retrieving the disambiguation ID from the requested URI /affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][serviceURL=/public/saml2slosoap/]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][FWSBase.java][getDisambiguationID][serviceURL /public/saml2slosoap/ not found in requestedURI /affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SAMLTunnelClient.java][callSingleLogout][localURL: https://sit.auth.optus.com.au/affwebservices/public/saml2slo]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SAMLTunnelClient.java][callSingleLogout][Session ID: .]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Requesting data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][][agentcommon][][Administration Manager is returning data for ConfigManager ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/SmHost.conf and SmAgentConfig ID /opt/CA/secure-proxy/proxy-engine/conf/defaultagent/WebAgent.conf]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SAMLTunnelClient.java][callSingleLogout][Tunnel result code: 1.]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][
TUNNEL STATUS:
status : 0
message : ]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][Transaction with ID: d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b failed. Reason: SLO_TUNNEL_CALL_FAILED]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][Single Logout Tunnel call failed. Failure code: 0. Message: .]
[12/20/2019][00:41:36][24892][139758777112320][d521e97d-3cffa725-9d41800c-8dc36ade-fa5deefc-3b][SLOService.java][handleLogout][Ending SAML2 Single Logout Service request processing with HTTP error 500]
Original Message:
Sent: 01-18-2018 05:56 PM
From: Ujwol Shrestha
Subject: Re: FWSB_INVALID_SMSESSION error during SLO
Could you provide following from the time of the issue :
- Fiddler log
- Fws trace log
- Web agent trace log