2024-08-09 19:19:50,998 - 0:0:0:0:0:0:0:1 - INFO [Shibboleth-Audit.SSO:333] - 0:0:0:0:0:0:0:1|2024-08-09T13:49:50.484742900Z|2024-08-09T13:49:50.998125200Z||http://ipau.sp.sso.manager/sso||||||||false||POST||EndpointResolutionFailed||||Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36
2024-08-09 19:21:27,344 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.LoggingService': Reload interval set to: PT5M, starting refresh thread
2024-08-09 19:21:27,464 -  - INFO [net.shibboleth.shared.xml.impl.BasicParserPool:648] - XMLSecurityManager of type 'com.sun.org.apache.xerces.internal.utils.XMLSecurityManager' is installed
2024-08-09 19:21:27,471 -  - INFO [org.opensaml.core.config.InitializationService:47] - Initializing OpenSAML using the Java Services API
2024-08-09 19:21:29,887 -  - INFO [org.opensaml.xmlsec.algorithm.AlgorithmRegistry:273] - Algorithm failed runtime support check, will not be usable: http://www.w3.org/2001/04/xmlenc#ripemd160
2024-08-09 19:21:29,900 -  - INFO [org.opensaml.xmlsec.algorithm.AlgorithmRegistry:273] - Algorithm failed runtime support check, will not be usable: http://www.w3.org/2001/04/xmldsig-more#hmac-ripemd160
2024-08-09 19:21:29,937 -  - INFO [org.opensaml.xmlsec.algorithm.AlgorithmRegistry:273] - Algorithm failed runtime support check, will not be usable: http://www.w3.org/2001/04/xmldsig-more#rsa-ripemd160
2024-08-09 19:21:30,370 -  - INFO [net.shibboleth.shared.security.impl.BasicKeystoreKeyStrategy:379] - Loading initial default key: secret1
2024-08-09 19:21:30,452 -  - INFO [net.shibboleth.shared.security.impl.BasicKeystoreKeyStrategy:391] - Default key updated to secret1
2024-08-09 19:21:30,730 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.AttributeRegistryService': Performing initial load
2024-08-09 19:21:30,730 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.AttributeRegistryService': Reloading service configuration
2024-08-09 19:21:31,075 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.AttributeRegistryService': Completed reload and swapped in latest configuration for service 'shibboleth.AttributeRegistryService'
2024-08-09 19:21:31,075 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.AttributeRegistryService': Reload complete
2024-08-09 19:21:31,076 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.AttributeRegistryService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:31,085 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.MetadataResolverService': Performing initial load
2024-08-09 19:21:31,086 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.MetadataResolverService': Reloading service configuration
2024-08-09 19:21:31,206 -  - WARN [org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker:437] - Bean 'org.opensaml.saml.metadata.resolver.filter.impl.EntitiesDescriptorNameProcessor#0' of type [org.opensaml.saml.metadata.resolver.filter.impl.EntitiesDescriptorNameProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected into a currently created BeanPostProcessor [net.shibboleth.spring.metadata.NodeProcessingAttachingBeanPostProcessor#0]? Check the corresponding BeanPostProcessor declaration and its dependencies.
2024-08-09 19:21:31,208 -  - WARN [org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker:437] - Bean 'net.shibboleth.idp.saml.security.impl.KeyAuthorityNodeProcessor#0' of type [net.shibboleth.idp.saml.security.impl.KeyAuthorityNodeProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected into a currently created BeanPostProcessor [net.shibboleth.spring.metadata.NodeProcessingAttachingBeanPostProcessor#0]? Check the corresponding BeanPostProcessor declaration and its dependencies.
2024-08-09 19:21:31,211 -  - WARN [org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker:437] - Bean 'net.shibboleth.idp.saml.metadata.impl.ScopesNodeProcessor#0' of type [net.shibboleth.idp.saml.metadata.impl.ScopesNodeProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected into a currently created BeanPostProcessor [net.shibboleth.spring.metadata.NodeProcessingAttachingBeanPostProcessor#0]? Check the corresponding BeanPostProcessor declaration and its dependencies.
2024-08-09 19:21:31,212 -  - WARN [org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker:437] - Bean 'net.shibboleth.idp.saml.metadata.impl.UIInfoNodeProcessor#0' of type [net.shibboleth.idp.saml.metadata.impl.UIInfoNodeProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected into a currently created BeanPostProcessor [net.shibboleth.spring.metadata.NodeProcessingAttachingBeanPostProcessor#0]? Check the corresponding BeanPostProcessor declaration and its dependencies.
2024-08-09 19:21:31,213 -  - WARN [org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker:437] - Bean 'net.shibboleth.idp.saml.attribute.impl.AttributeMappingNodeProcessor#0' of type [net.shibboleth.idp.saml.attribute.impl.AttributeMappingNodeProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected into a currently created BeanPostProcessor [net.shibboleth.spring.metadata.NodeProcessingAttachingBeanPostProcessor#0]? Check the corresponding BeanPostProcessor declaration and its dependencies.
2024-08-09 19:21:31,328 -  - INFO [org.opensaml.saml.metadata.resolver.impl.AbstractReloadingMetadataResolver:627] - FilesystemMetadataResolver ipau.sp.sso.manager.http: New metadata successfully loaded for 'D:\Apps\IdP\metadata\iPAU-SP-metadata.xml'
2024-08-09 19:21:31,329 -  - INFO [org.opensaml.saml.metadata.resolver.impl.AbstractReloadingMetadataResolver:426] - FilesystemMetadataResolver ipau.sp.sso.manager.http: Next refresh cycle for metadata provider 'D:\Apps\IdP\metadata\iPAU-SP-metadata.xml' will occur on '2024-08-10T07:51:31.280237100Z' ('2024-08-10T13:21:31.280237100+05:30[Asia/Calcutta]' local time)
2024-08-09 19:21:31,343 -  - INFO [org.opensaml.saml.metadata.resolver.impl.AbstractReloadingMetadataResolver:627] - FilesystemMetadataResolver ipau.sp.sso.manager.https: New metadata successfully loaded for 'D:\Apps\IdP\metadata\iPAU-SP-https-metadata.xml'
2024-08-09 19:21:31,343 -  - INFO [org.opensaml.saml.metadata.resolver.impl.AbstractReloadingMetadataResolver:426] - FilesystemMetadataResolver ipau.sp.sso.manager.https: Next refresh cycle for metadata provider 'D:\Apps\IdP\metadata\iPAU-SP-https-metadata.xml' will occur on '2024-08-10T07:51:31.335175900Z' ('2024-08-10T13:21:31.335175900+05:30[Asia/Calcutta]' local time)
2024-08-09 19:21:31,344 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.MetadataResolverService': Completed reload and swapped in latest configuration for service 'shibboleth.MetadataResolverService'
2024-08-09 19:21:31,344 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.MetadataResolverService': Reload complete
2024-08-09 19:21:31,501 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.AttributeFilterService': Performing initial load
2024-08-09 19:21:31,501 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.AttributeFilterService': Reloading service configuration
2024-08-09 19:21:31,588 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.AttributeFilterService': Completed reload and swapped in latest configuration for service 'shibboleth.AttributeFilterService'
2024-08-09 19:21:31,588 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.AttributeFilterService': Reload complete
2024-08-09 19:21:31,589 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.AttributeFilterService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:31,597 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.AttributeResolverService': Performing initial load
2024-08-09 19:21:31,597 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.AttributeResolverService': Reloading service configuration
2024-08-09 19:21:31,627 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.AttributeResolverService': Completed reload and swapped in latest configuration for service 'shibboleth.AttributeResolverService'
2024-08-09 19:21:31,628 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.AttributeResolverService': Reload complete
2024-08-09 19:21:31,628 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.AttributeResolverService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:31,637 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.NameIdentifierGenerationService': Performing initial load
2024-08-09 19:21:31,638 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.NameIdentifierGenerationService': Reloading service configuration
2024-08-09 19:21:31,689 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.NameIdentifierGenerationService': Completed reload and swapped in latest configuration for service 'shibboleth.NameIdentifierGenerationService'
2024-08-09 19:21:31,689 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.NameIdentifierGenerationService': Reload complete
2024-08-09 19:21:31,690 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.NameIdentifierGenerationService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:31,697 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.RelyingPartyResolverService': Performing initial load
2024-08-09 19:21:31,698 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.RelyingPartyResolverService': Reloading service configuration
2024-08-09 19:21:32,164 -  - WARN [DEPRECATED:123] - Spring bean 'Liberty.SSOS or Liberty.SSOS.MDDriven', (relying-party.xml): This will be removed in the next major version of this software; replacement is (none)
2024-08-09 19:21:32,221 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.RelyingPartyResolverService': Completed reload and swapped in latest configuration for service 'shibboleth.RelyingPartyResolverService'
2024-08-09 19:21:32,221 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.RelyingPartyResolverService': Reload complete
2024-08-09 19:21:32,222 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.RelyingPartyResolverService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:32,226 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.ReloadableAccessControlService': Performing initial load
2024-08-09 19:21:32,226 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.ReloadableAccessControlService': Reloading service configuration
2024-08-09 19:21:32,249 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.ReloadableAccessControlService': Completed reload and swapped in latest configuration for service 'shibboleth.ReloadableAccessControlService'
2024-08-09 19:21:32,249 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.ReloadableAccessControlService': Reload complete
2024-08-09 19:21:32,251 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.ReloadableAccessControlService': Reload interval set to: PT5M, starting refresh thread
2024-08-09 19:21:32,255 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.ReloadableCASServiceRegistry': Performing initial load
2024-08-09 19:21:32,256 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.ReloadableCASServiceRegistry': Reloading service configuration
2024-08-09 19:21:32,267 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.ReloadableCASServiceRegistry': Completed reload and swapped in latest configuration for service 'shibboleth.ReloadableCASServiceRegistry'
2024-08-09 19:21:32,267 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.ReloadableCASServiceRegistry': Reload complete
2024-08-09 19:21:32,268 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.ReloadableCASServiceRegistry': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:32,273 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:170] - Service 'shibboleth.ManagedBeanService': Performing initial load
2024-08-09 19:21:32,273 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:258] - Service 'shibboleth.ManagedBeanService': Reloading service configuration
2024-08-09 19:21:32,274 -  - INFO [net.shibboleth.shared.spring.util.ApplicationContextBuilder:473] - Skipping non-existent resource: ServletContext resource [/D:/Apps/IdP/conf/managed-beans.xml]
2024-08-09 19:21:32,275 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:419] - Service 'shibboleth.ManagedBeanService': Completed reload and swapped in latest configuration for service 'shibboleth.ManagedBeanService'
2024-08-09 19:21:32,276 -  - INFO [net.shibboleth.shared.spring.service.ReloadableSpringService:426] - Service 'shibboleth.ManagedBeanService': Reload complete
2024-08-09 19:21:32,277 -  - INFO [net.shibboleth.shared.service.AbstractReloadableService:198] - Service 'shibboleth.ManagedBeanService': Reload interval set to: PT15M, starting refresh thread
2024-08-09 19:21:33,797 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:57] - Shibboleth IdP Version 5.1.3
2024-08-09 19:21:33,798 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:58] - Java version='17.0.8' vendor='Eclipse Adoptium'
2024-08-09 19:21:33,798 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:71] - No Plugins Loaded
2024-08-09 19:21:33,802 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:93] - Enabled Modules:
2024-08-09 19:21:33,804 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:95] - 		Core IdP Functions (Required)
2024-08-09 19:21:33,804 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:95] - 		Password Authentication
2024-08-09 19:21:33,804 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:95] - 		Hello World
2024-08-09 19:21:33,804 -  - INFO [net.shibboleth.idp.admin.impl.LogImplementationDetails:95] - 		Impersonation Interceptor
2024-08-09 19:21:34,283 -  - INFO [org.springframework.web.context.ContextLoader:288] - Root WebApplicationContext initialized in 11407 ms
2024-08-09 19:21:34,377 -  - INFO [net.shibboleth.idp.admin.impl.ReportUpdateStatus:136] - No upgrade available from 5.1.3
2024-08-09 19:21:34,381 -  - INFO [net.shibboleth.idp.admin.impl.ReportUpdateStatus:147] - Version 5.1.3 is current
2024-08-09 19:22:04,976 -  - INFO [org.springframework.web.servlet.DispatcherServlet:532] - Initializing Servlet 'idp'
2024-08-09 19:22:06,051 -  - INFO [org.springframework.web.servlet.DispatcherServlet:554] - Completed initialization in 1074 ms
2024-08-09 19:22:06,821 - 0:0:0:0:0:0:0:1 - WARN [net.shibboleth.idp.saml.profile.impl.PopulateBindingAndEndpointContexts:449] - Profile Action PopulateBindingAndEndpointContexts: Unable to resolve outbound message endpoint for relying party 'http://ipau.sp.sso.manager/sso': EndpointCriterion [type={urn:oasis:names:tc:SAML:2.0:metadata}AssertionConsumerService, Binding=urn:oasis:names:tc:SAML:2.0:bindings:HTTP-POST, Location=http://localhost:8080/SSOSPManager/SSO, trusted=false]
2024-08-09 19:22:06,827 - 0:0:0:0:0:0:0:1 - WARN [org.opensaml.profile.action.impl.LogEvent:94] - A non-proceed event occurred while processing the request: EndpointResolutionFailed
2024-08-09 19:22:06,846 - 0:0:0:0:0:0:0:1 - INFO [Shibboleth-Audit.SSO:333] - 0:0:0:0:0:0:0:1|2024-08-09T13:52:06.504772200Z|2024-08-09T13:52:06.846088500Z||http://ipau.sp.sso.manager/sso||||||||false||POST||EndpointResolutionFailed||||Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36