By: Jeremy Hicks user 28 Jul 2020 at 4:53 p.m. CDT

3 Responses
Jeremy Hicks gravatar
REMOTE_USER=UID REMOTE_USER=asicnwAUbafuB12354UY..../ahdlkfghas.... Log contents /opt/gluu/jetty/oxauth/logs/oxauth.log ``` 2020-07-28 14:26:33,091 INFO [qtp1359044626-14] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='d7e9fe7c-18c5-4a04-a694-4a3f318f74ec', id='d7e9fe7c-18c5-4a04-a694-4a3f318f74ec', lastUsedAt=Tue Jul 28 14:26:33 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 14:26:33 CDT 2020, state=authenticated, sessionState='445da1f06e7aeeb52b92e74bb8012b3212d81743e2ac27d2c33314cd0fe5e455.bbb7123a-491f-42e2-95ff-67c58ba21f79', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@5735c53e, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=612e1909-da84-4705-87f6-b9cfcd6fc799, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6ImczMEdWU2hrcXUiLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=9MWbusLwPp, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 14:26:33,093 INFO [qtp1359044626-14] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@7340b58b 2020-07-28 14:26:33,094 INFO [qtp1359044626-14] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 14:26:33,277 INFO [qtp1359044626-14] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 14:36:08,113 INFO [Thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:627) - Stopping services and closing DB connections at server shutdown... 2020-07-28 14:36:08,184 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:694) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutting down. 2020-07-28 14:36:08,185 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:613) - Scheduler oxAuthScheduler_$_NON_CLUSTERED paused. 2020-07-28 14:36:08,190 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:771) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutdown complete. 2020-07-28 14:36:08,190 INFO [Thread-1] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:150) - Quartz scheduler manager destroyed 2020-07-28 14:38:17,735 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:58) - WELD-ENV-001008: Initialize Weld using ServletContainerInitializer 2020-07-28 14:38:17,783 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:149) - WELD-000900: 3.1.1 (Final) 2020-07-28 14:38:18,224 INFO [main] [jboss.weld.environment.deployment.discovery.ReflectionDiscoveryStrategy] (ReflectionDiscoveryStrategy.java:49) - WELD-ENV-000014: Falling back to Java Reflection for bean-discovery-mode="annotated" discovery. Add org.jboss:jandex to the classpath to speed-up startup. 2020-07-28 14:38:18,627 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:231) - WELD-000101: Transactional services not available. Injection of @Inject UserTransaction not available. Transactional observers will be invoked synchronously. 2020-07-28 14:38:18,843 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.exception.ExceptionHandlerExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 14:38:18,865 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.security.SecurityExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 14:38:18,926 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class org.hibernate.validator.internal.cdi.interceptor.ValidationInterceptor is deprecated from CDI 1.1! 2020-07-28 14:38:18,940 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class com.sun.faces.flow.FlowDiscoveryCDIHelper is deprecated from CDI 1.1! 2020-07-28 14:38:22,621 INFO [main] [org.jboss.weld.environment.jetty.JettyContainer] (JettyContainer.java:77) - WELD-ENV-001200: Jetty 7.2+ detected, CDI injection will be available in Servlets and Filters. Injection into Listeners should work on Jetty 9.1.1 and newer. 2020-07-28 14:38:22,702 WARN [weld-worker-1] [org.jboss.weld.bootstrap.BeanDeployer] (BeanDeployer.java:229) - WELD-000167: Class org.gluu.persist.couchbase.impl.CouchbaseFilterConverter is annotated with @ApplicationScoped but it does not declare an appropriate constructor therefore is not registered as a bean! 2020-07-28 14:38:24,140 INFO [main] [org.gluu.oxauth.model.util.SecurityProviderUtility] (SecurityProviderUtility.java:24) - Adding Bouncy Castle Provider 2020-07-28 14:38:24,220 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:369) - Loading configuration from 'ldap' DB... 2020-07-28 14:38:26,109 INFO [main] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:346) - Created persistenceEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@24fe3184 with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@219505d9 2020-07-28 14:38:26,551 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:179) - External log configuration: 2020-07-28 14:38:26,552 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:122) - Setting loggers level to: 'INFO' 2020-07-28 14:38:26,564 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:186) - Configuration loaded successfully. 2020-07-28 14:38:27,902 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1172) - Using default implementation for ThreadExecutor 2020-07-28 14:38:27,926 INFO [main] [org.quartz.core.SchedulerSignalerImpl] (SchedulerSignalerImpl.java:61) - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 2020-07-28 14:38:27,927 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:240) - Quartz Scheduler v.2.2.3 created. 2020-07-28 14:38:27,928 INFO [main] [org.quartz.simpl.RAMJobStore] (RAMJobStore.java:155) - RAMJobStore initialized. 2020-07-28 14:38:27,929 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:305) - Scheduler meta-data: Quartz Scheduler (v2.2.3) 'oxAuthScheduler' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 5 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 2020-07-28 14:38:27,930 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1327) - Quartz scheduler 'oxAuthScheduler' initialized from the specified file : 'quartz.properties' from the class resource path. 2020-07-28 14:38:27,931 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1331) - Quartz scheduler version: 2.2.3 2020-07-28 14:38:27,933 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:2311) - JobFactory set to: org.gluu.service.timer.JobExecutionFactory@2bd9722 2020-07-28 14:38:27,933 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:62) - Quartz scheduler manager initialized 2020-07-28 14:38:27,933 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:575) - Scheduler oxAuthScheduler_$_NON_CLUSTERED started. 2020-07-28 14:38:27,934 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:115) - Quartz scheduler started 2020-07-28 14:38:27,971 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:47) - Initializing Logger Update Timer 2020-07-28 14:38:28,052 INFO [main] [org.gluu.oxauth.fido2.certification.DirectoryBasedMetadataLoader] (DirectoryBasedMetadataLoader.java:68) - Populating metadata from /etc/gluu/conf/fido2/server_metadata 2020-07-28 14:38:28,176 INFO [main] [gluu.oxauth.fido2.service.mds.MdsTocService] (MdsTocService.java:111) - Populating TOC entries from /etc/gluu/conf/fido2/mds/toc 2020-07-28 14:38:28,466 INFO [main] [org.jboss.weld.environment.servlet.Listener] (Listener.java:112) - WELD-ENV-001006: org.jboss.weld.environment.servlet.EnhancedListener used to initialize Weld 2020-07-28 14:38:30,696 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:75) - WELD-ENV-001009: org.jboss.weld.environment.servlet.Listener used for ServletRequest and HttpSession notifications 2020-07-28 14:38:30,985 INFO [main] [org.jboss.resteasy.spi.ResteasyDeployment] (ResteasyDeployment.java:546) - RESTEASY002225: Deploying javax.ws.rs.core.Application: class org.gluu.oxauth.service.ResteasyInitializer$Proxy$_$$_WeldClientProxy 2020-07-28 14:38:30,986 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.PatchMethodFilter is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,986 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,986 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlSeeAlsoProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,990 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.JaxrsFormProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,996 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.InputStreamProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,998 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventSinkInterceptor is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,998 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.XmlJAXBContextFinder is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,999 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.UnrecognizedPropertyExceptionHandler is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,999 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlTypeProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:30,999 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultBooleanWriter is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,000 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.StringTextStar is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,014 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DataSourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,014 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.CollectionProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,042 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,043 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.MapProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,043 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultNumberWriter is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,043 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.interceptors.encoding.MessageSanitizerContainerResponseFilter is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,044 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultTextPlain is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,044 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.IIOImageProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,045 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,045 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FormUrlEncodedProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,046 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlRootElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,047 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventOutputProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,047 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DocumentProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,048 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FileProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,048 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.ReaderProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:38:31,048 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.SourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 14:41:37,146 INFO [qtp1359044626-18] [org.gluu.oxauth.service.ApplicationFactory] (ApplicationFactory.java:82) - Cache configuration: CacheConfiguration{cacheProviderType=IN_MEMORY, memcachedConfiguration=MemcachedConfiguration{servers='localhost:11211', maxOperationQueueLength=100000, bufferSize=32768, defaultPutExpiration=60, connectionFactoryType=DEFAULT}, redisConfiguration=RedisConfiguration{servers='localhost:6379', defaultPutExpiration=60, redisProviderType=STANDALONE, useSSL=false, sslTrustStoreFilePath=}, inMemoryConfiguration=InMemoryConfiguration{defaultPutExpiration=60}, nativePersistenceConfiguration=NativePersistenceConfiguration [defaultPutExpiration=60, defaultCleanupBatchSize=25, baseDn=o=gluu]} 2020-07-28 14:41:41,366 INFO [qtp1359044626-13] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='af78b4ba-da50-4675-b164-07748c946f18', id='af78b4ba-da50-4675-b164-07748c946f18', lastUsedAt=Tue Jul 28 14:41:41 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 14:41:41 CDT 2020, state=authenticated, sessionState='557a69233d03cada438d51f5106aab1e5b22385da942e7a6531c8098f2f9f448.5a868742-3a24-49c6-8016-ccf153f57170', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@44b35fa5, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=29c58f2d-a37f-4ea1-a1e1-c79625b8e717, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6Ik1JVTRtQmtzaHIiLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=tn2izFX8vK, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 14:41:41,368 INFO [qtp1359044626-13] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@2a158adb 2020-07-28 14:41:41,369 INFO [qtp1359044626-13] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 14:41:41,582 INFO [qtp1359044626-19] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 14:42:10,351 INFO [qtp1359044626-19] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1001.7ecc44c8-d2bd-43cf-9079-419236c6a3e6' 2020-07-28 14:43:28,250 INFO [metrics-reporter-1-thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:363) - Created persistenceMetricEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@7788c567 with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@2fca6cb3 2020-07-28 15:04:42,865 INFO [Thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:627) - Stopping services and closing DB connections at server shutdown... 2020-07-28 15:04:42,952 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:694) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutting down. 2020-07-28 15:04:42,953 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:613) - Scheduler oxAuthScheduler_$_NON_CLUSTERED paused. 2020-07-28 15:04:42,954 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:771) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutdown complete. 2020-07-28 15:04:42,954 INFO [Thread-1] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:150) - Quartz scheduler manager destroyed 2020-07-28 15:05:24,349 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:58) - WELD-ENV-001008: Initialize Weld using ServletContainerInitializer 2020-07-28 15:05:24,391 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:149) - WELD-000900: 3.1.1 (Final) 2020-07-28 15:05:24,850 INFO [main] [jboss.weld.environment.deployment.discovery.ReflectionDiscoveryStrategy] (ReflectionDiscoveryStrategy.java:49) - WELD-ENV-000014: Falling back to Java Reflection for bean-discovery-mode="annotated" discovery. Add org.jboss:jandex to the classpath to speed-up startup. 2020-07-28 15:05:25,233 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:231) - WELD-000101: Transactional services not available. Injection of @Inject UserTransaction not available. Transactional observers will be invoked synchronously. 2020-07-28 15:05:25,446 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.exception.ExceptionHandlerExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 15:05:25,460 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.security.SecurityExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 15:05:25,510 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class org.hibernate.validator.internal.cdi.interceptor.ValidationInterceptor is deprecated from CDI 1.1! 2020-07-28 15:05:25,524 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class com.sun.faces.flow.FlowDiscoveryCDIHelper is deprecated from CDI 1.1! 2020-07-28 15:05:28,064 INFO [main] [org.jboss.weld.environment.jetty.JettyContainer] (JettyContainer.java:77) - WELD-ENV-001200: Jetty 7.2+ detected, CDI injection will be available in Servlets and Filters. Injection into Listeners should work on Jetty 9.1.1 and newer. 2020-07-28 15:05:28,132 WARN [weld-worker-1] [org.jboss.weld.bootstrap.BeanDeployer] (BeanDeployer.java:229) - WELD-000167: Class org.gluu.persist.couchbase.impl.CouchbaseFilterConverter is annotated with @ApplicationScoped but it does not declare an appropriate constructor therefore is not registered as a bean! 2020-07-28 15:05:29,404 INFO [main] [org.gluu.oxauth.model.util.SecurityProviderUtility] (SecurityProviderUtility.java:24) - Adding Bouncy Castle Provider 2020-07-28 15:05:29,493 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:369) - Loading configuration from 'ldap' DB... 2020-07-28 15:05:31,268 INFO [main] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:346) - Created persistenceEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@5709c30b with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@25607b86 2020-07-28 15:05:31,579 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:179) - External log configuration: 2020-07-28 15:05:31,580 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:122) - Setting loggers level to: 'INFO' 2020-07-28 15:05:31,585 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:186) - Configuration loaded successfully. 2020-07-28 15:05:32,712 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1172) - Using default implementation for ThreadExecutor 2020-07-28 15:05:32,735 INFO [main] [org.quartz.core.SchedulerSignalerImpl] (SchedulerSignalerImpl.java:61) - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 2020-07-28 15:05:32,735 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:240) - Quartz Scheduler v.2.2.3 created. 2020-07-28 15:05:32,737 INFO [main] [org.quartz.simpl.RAMJobStore] (RAMJobStore.java:155) - RAMJobStore initialized. 2020-07-28 15:05:32,738 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:305) - Scheduler meta-data: Quartz Scheduler (v2.2.3) 'oxAuthScheduler' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 5 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 2020-07-28 15:05:32,738 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1327) - Quartz scheduler 'oxAuthScheduler' initialized from the specified file : 'quartz.properties' from the class resource path. 2020-07-28 15:05:32,738 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1331) - Quartz scheduler version: 2.2.3 2020-07-28 15:05:32,742 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:2311) - JobFactory set to: org.gluu.service.timer.JobExecutionFactory@159d2313 2020-07-28 15:05:32,742 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:62) - Quartz scheduler manager initialized 2020-07-28 15:05:32,743 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:575) - Scheduler oxAuthScheduler_$_NON_CLUSTERED started. 2020-07-28 15:05:32,743 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:115) - Quartz scheduler started 2020-07-28 15:05:32,778 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:47) - Initializing Logger Update Timer 2020-07-28 15:05:32,851 INFO [main] [org.gluu.oxauth.fido2.certification.DirectoryBasedMetadataLoader] (DirectoryBasedMetadataLoader.java:68) - Populating metadata from /etc/gluu/conf/fido2/server_metadata 2020-07-28 15:05:32,967 INFO [main] [gluu.oxauth.fido2.service.mds.MdsTocService] (MdsTocService.java:111) - Populating TOC entries from /etc/gluu/conf/fido2/mds/toc 2020-07-28 15:05:33,138 INFO [main] [org.jboss.weld.environment.servlet.Listener] (Listener.java:112) - WELD-ENV-001006: org.jboss.weld.environment.servlet.EnhancedListener used to initialize Weld 2020-07-28 15:05:35,043 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:75) - WELD-ENV-001009: org.jboss.weld.environment.servlet.Listener used for ServletRequest and HttpSession notifications 2020-07-28 15:05:35,324 INFO [main] [org.jboss.resteasy.spi.ResteasyDeployment] (ResteasyDeployment.java:546) - RESTEASY002225: Deploying javax.ws.rs.core.Application: class org.gluu.oxauth.service.ResteasyInitializer$Proxy$_$$_WeldClientProxy 2020-07-28 15:05:35,325 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.PatchMethodFilter is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,325 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,326 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlSeeAlsoProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,326 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.JaxrsFormProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,333 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.InputStreamProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,335 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventSinkInterceptor is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,335 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.XmlJAXBContextFinder is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,336 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.UnrecognizedPropertyExceptionHandler is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,336 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlTypeProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,337 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultBooleanWriter is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,337 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.StringTextStar is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,350 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DataSourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,350 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.CollectionProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,363 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,364 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.MapProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,364 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultNumberWriter is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,364 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.interceptors.encoding.MessageSanitizerContainerResponseFilter is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,365 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultTextPlain is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,365 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.IIOImageProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,366 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,366 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FormUrlEncodedProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,366 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlRootElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,372 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventOutputProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,373 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DocumentProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,373 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FileProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,373 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.ReaderProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:05:35,374 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.SourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 15:06:45,748 INFO [qtp1359044626-15] [org.gluu.oxauth.service.ApplicationFactory] (ApplicationFactory.java:82) - Cache configuration: CacheConfiguration{cacheProviderType=IN_MEMORY, memcachedConfiguration=MemcachedConfiguration{servers='localhost:11211', maxOperationQueueLength=100000, bufferSize=32768, defaultPutExpiration=60, connectionFactoryType=DEFAULT}, redisConfiguration=RedisConfiguration{servers='localhost:6379', defaultPutExpiration=60, redisProviderType=STANDALONE, useSSL=false, sslTrustStoreFilePath=}, inMemoryConfiguration=InMemoryConfiguration{defaultPutExpiration=60}, nativePersistenceConfiguration=NativePersistenceConfiguration [defaultPutExpiration=60, defaultCleanupBatchSize=25, baseDn=o=gluu]} 2020-07-28 15:06:46,303 ERROR [qtp1359044626-19] [gluu.oxauth.session.ws.rs.EndSessionRestWebServiceImpl] (EndSessionRestWebServiceImpl.java:310) - Failed to load session by session_id: 'af78b4ba-da50-4675-b164-07748c946f18' 2020-07-28 15:07:12,028 INFO [qtp1359044626-69] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='c1bfc911-4882-475a-9668-94155a6e3b6c', id='c1bfc911-4882-475a-9668-94155a6e3b6c', lastUsedAt=Tue Jul 28 15:07:12 CDT 2020, userDn='inum=0000!8DB7.CCFC,ou=people,o=gluu', authenticationTime=Tue Jul 28 15:07:12 CDT 2020, state=authenticated, sessionState='ccda2a9fb86e6dd3ca1d26fa8aa0da9d18bacff6aa34d828a10a2a72602e79a2.d0844252-1291-4b07-ba89-599ec50acd90', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@388c2520, involvedClients=null, sessionAttributes={auth_external_attributes=null, opbs=87b0c56f-5449-4857-938a-37977f16f88d, response_type=code, nonce=3d527edd-8d8a-446a-8ef0-418d84d89ffe, client_id=1001.7ecc44c8-d2bd-43cf-9079-419236c6a3e6, auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_user=Administrator, scope=openid profile email user_name, acr_values=auth_ldap_server, redirect_uri=https://signon.caeservices.com/identity/authcode.htm, state=860bdd5e-9434-4322-8a69-2e7eccd1e8f6}, persisted=true} 2020-07-28 15:07:12,029 INFO [qtp1359044626-69] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@658d9cfa 2020-07-28 15:07:12,030 INFO [qtp1359044626-69] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'administrator' 2020-07-28 15:07:12,475 INFO [qtp1359044626-19] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1001.7ecc44c8-d2bd-43cf-9079-419236c6a3e6' 2020-07-28 15:10:33,055 INFO [metrics-reporter-1-thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:363) - Created persistenceMetricEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@17684ee3 with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@32392b5 2020-07-28 15:17:53,313 INFO [qtp1359044626-67] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='2f232246-1299-4b72-9cd2-c7bf3d175a97', id='2f232246-1299-4b72-9cd2-c7bf3d175a97', lastUsedAt=Tue Jul 28 15:17:53 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 15:17:53 CDT 2020, state=authenticated, sessionState='bc66219fc19f8982f59240a716d8d7646014dd04d561cba6045367c675137a9d.e32b191a-d874-485e-b035-d15569a41dd8', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@1f6c6f50, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=e1b06546-2044-4b54-a6a8-10f1686c5dd4, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6Imc5TGM5bE1mV2UiLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=Ipx80zSa7w, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 15:17:53,314 INFO [qtp1359044626-67] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@438a9bd1 2020-07-28 15:17:53,315 INFO [qtp1359044626-67] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 15:17:53,492 INFO [qtp1359044626-69] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 15:28:45,206 INFO [qtp1359044626-18] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 15:57:58,214 INFO [qtp1359044626-18] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 15:58:37,055 INFO [qtp1359044626-10] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='e49f0d68-52d8-433e-8e3c-29122ccb427a', id='e49f0d68-52d8-433e-8e3c-29122ccb427a', lastUsedAt=Tue Jul 28 15:58:37 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 15:58:37 CDT 2020, state=authenticated, sessionState='98f4f536c34922a0fd87e82c5d752b87bbbf46c2f95f88a0f6fbdd9482015609.4e7a0f50-f010-4ff7-a94a-812df84a776a', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@6bc8af33, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=f7e75b71-ecf1-4077-9aa5-2773c34f4548, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6IjVmcnJmcTFKM0ciLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=MpUMLlGHm0, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 15:58:37,056 INFO [qtp1359044626-10] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@18d9933e 2020-07-28 15:58:37,057 INFO [qtp1359044626-10] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 15:58:37,230 INFO [qtp1359044626-14] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 16:13:58,174 INFO [qtp1359044626-68] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='779e8394-ba29-4c5e-97b7-4b27949c489d', id='779e8394-ba29-4c5e-97b7-4b27949c489d', lastUsedAt=Tue Jul 28 16:13:58 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 16:13:58 CDT 2020, state=authenticated, sessionState='a7e9b14ce0c182f10f9123e7b3e11b0f8cd0b29b67aa1a31054417616971da0e.6bfbaeef-202b-4436-bb6c-631f935c7acf', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@31ae1860, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=335fc4d5-806a-47fa-9951-cc7bfd76fc32, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6IlJueERzZDNaQnciLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=NgbMKTUtR2, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 16:13:58,175 INFO [qtp1359044626-68] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@3cfa8b0 2020-07-28 16:13:58,176 INFO [qtp1359044626-68] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 16:13:58,373 INFO [qtp1359044626-68] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 16:24:26,456 INFO [Thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:627) - Stopping services and closing DB connections at server shutdown... 2020-07-28 16:24:26,486 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:694) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutting down. 2020-07-28 16:24:26,486 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:613) - Scheduler oxAuthScheduler_$_NON_CLUSTERED paused. 2020-07-28 16:24:26,487 INFO [Thread-1] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:771) - Scheduler oxAuthScheduler_$_NON_CLUSTERED shutdown complete. 2020-07-28 16:24:26,487 INFO [Thread-1] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:150) - Quartz scheduler manager destroyed 2020-07-28 16:25:23,569 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:58) - WELD-ENV-001008: Initialize Weld using ServletContainerInitializer 2020-07-28 16:25:23,609 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:149) - WELD-000900: 3.1.1 (Final) 2020-07-28 16:25:24,035 INFO [main] [jboss.weld.environment.deployment.discovery.ReflectionDiscoveryStrategy] (ReflectionDiscoveryStrategy.java:49) - WELD-ENV-000014: Falling back to Java Reflection for bean-discovery-mode="annotated" discovery. Add org.jboss:jandex to the classpath to speed-up startup. 2020-07-28 16:25:24,428 INFO [main] [org.jboss.weld.bootstrap.WeldStartup] (WeldStartup.java:231) - WELD-000101: Transactional services not available. Injection of @Inject UserTransaction not available. Transactional observers will be invoked synchronously. 2020-07-28 16:25:24,652 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.exception.ExceptionHandlerExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 16:25:24,666 INFO [main] [org.jboss.weld.event.ExtensionObserverMethodImpl] (ExtensionObserverMethodImpl.java:86) - WELD-000411: Observer method [BackedAnnotatedMethod] public org.gluu.service.security.SecurityExtension.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2020-07-28 16:25:24,733 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class org.hibernate.validator.internal.cdi.interceptor.ValidationInterceptor is deprecated from CDI 1.1! 2020-07-28 16:25:24,761 WARN [main] [org.jboss.weld.bootstrap.events.BeforeBeanDiscoveryImpl] (BeforeBeanDiscoveryImpl.java:118) - WELD-000146: BeforeBeanDiscovery.addAnnotatedType(AnnotatedType) used for class com.sun.faces.flow.FlowDiscoveryCDIHelper is deprecated from CDI 1.1! 2020-07-28 16:25:27,387 INFO [main] [org.jboss.weld.environment.jetty.JettyContainer] (JettyContainer.java:77) - WELD-ENV-001200: Jetty 7.2+ detected, CDI injection will be available in Servlets and Filters. Injection into Listeners should work on Jetty 9.1.1 and newer. 2020-07-28 16:25:27,458 WARN [weld-worker-2] [org.jboss.weld.bootstrap.BeanDeployer] (BeanDeployer.java:229) - WELD-000167: Class org.gluu.persist.couchbase.impl.CouchbaseFilterConverter is annotated with @ApplicationScoped but it does not declare an appropriate constructor therefore is not registered as a bean! 2020-07-28 16:25:28,856 INFO [main] [org.gluu.oxauth.model.util.SecurityProviderUtility] (SecurityProviderUtility.java:24) - Adding Bouncy Castle Provider 2020-07-28 16:25:28,940 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:369) - Loading configuration from 'ldap' DB... 2020-07-28 16:25:30,932 INFO [main] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:346) - Created persistenceEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@7bdfd631 with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@1786e7a5 2020-07-28 16:25:31,257 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:179) - External log configuration: 2020-07-28 16:25:31,257 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:122) - Setting loggers level to: 'INFO' 2020-07-28 16:25:31,263 INFO [main] [org.gluu.oxauth.model.config.ConfigurationFactory] (ConfigurationFactory.java:186) - Configuration loaded successfully. 2020-07-28 16:25:32,380 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1172) - Using default implementation for ThreadExecutor 2020-07-28 16:25:32,404 INFO [main] [org.quartz.core.SchedulerSignalerImpl] (SchedulerSignalerImpl.java:61) - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 2020-07-28 16:25:32,405 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:240) - Quartz Scheduler v.2.2.3 created. 2020-07-28 16:25:32,406 INFO [main] [org.quartz.simpl.RAMJobStore] (RAMJobStore.java:155) - RAMJobStore initialized. 2020-07-28 16:25:32,407 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:305) - Scheduler meta-data: Quartz Scheduler (v2.2.3) 'oxAuthScheduler' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 5 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 2020-07-28 16:25:32,408 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1327) - Quartz scheduler 'oxAuthScheduler' initialized from the specified file : 'quartz.properties' from the class resource path. 2020-07-28 16:25:32,408 INFO [main] [org.quartz.impl.StdSchedulerFactory] (StdSchedulerFactory.java:1331) - Quartz scheduler version: 2.2.3 2020-07-28 16:25:32,410 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:2311) - JobFactory set to: org.gluu.service.timer.JobExecutionFactory@10c0d39d 2020-07-28 16:25:32,410 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:62) - Quartz scheduler manager initialized 2020-07-28 16:25:32,411 INFO [main] [org.quartz.core.QuartzScheduler] (QuartzScheduler.java:575) - Scheduler oxAuthScheduler_$_NON_CLUSTERED started. 2020-07-28 16:25:32,411 INFO [main] [org.gluu.service.timer.QuartzSchedulerManager] (QuartzSchedulerManager.java:115) - Quartz scheduler started 2020-07-28 16:25:32,444 INFO [main] [org.gluu.service.logger.LoggerService] (LoggerService.java:47) - Initializing Logger Update Timer 2020-07-28 16:25:32,511 INFO [main] [org.gluu.oxauth.fido2.certification.DirectoryBasedMetadataLoader] (DirectoryBasedMetadataLoader.java:68) - Populating metadata from /etc/gluu/conf/fido2/server_metadata 2020-07-28 16:25:32,687 INFO [main] [gluu.oxauth.fido2.service.mds.MdsTocService] (MdsTocService.java:111) - Populating TOC entries from /etc/gluu/conf/fido2/mds/toc 2020-07-28 16:25:32,869 INFO [main] [org.jboss.weld.environment.servlet.Listener] (Listener.java:112) - WELD-ENV-001006: org.jboss.weld.environment.servlet.EnhancedListener used to initialize Weld 2020-07-28 16:25:34,939 INFO [main] [org.jboss.weld.environment.servlet.EnhancedListener] (EnhancedListener.java:75) - WELD-ENV-001009: org.jboss.weld.environment.servlet.Listener used for ServletRequest and HttpSession notifications 2020-07-28 16:25:35,345 INFO [main] [org.jboss.resteasy.spi.ResteasyDeployment] (ResteasyDeployment.java:546) - RESTEASY002225: Deploying javax.ws.rs.core.Application: class org.gluu.oxauth.service.ResteasyInitializer$Proxy$_$$_WeldClientProxy 2020-07-28 16:25:35,346 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.PatchMethodFilter is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,346 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,347 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlSeeAlsoProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,347 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.JaxrsFormProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,351 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.InputStreamProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,352 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventSinkInterceptor is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,353 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.XmlJAXBContextFinder is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,353 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jackson.UnrecognizedPropertyExceptionHandler is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,354 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlTypeProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,354 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultBooleanWriter is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,372 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.StringTextStar is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,379 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DataSourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,380 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.CollectionProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,409 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,410 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.MapProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,410 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultNumberWriter is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,410 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.interceptors.encoding.MessageSanitizerContainerResponseFilter is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,411 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DefaultTextPlain is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,411 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.IIOImageProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,418 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,418 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FormUrlEncodedProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,418 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.jaxb.JAXBXmlRootElementProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,420 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.sse.SseEventOutputProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,420 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.DocumentProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,420 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.FileProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,421 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.ReaderProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:25:35,421 WARN [main] [org.jboss.resteasy.spi.ResteasyProviderFactory] (ResteasyProviderFactory.java:1675) - RESTEASY002155: Provider class org.jboss.resteasy.plugins.providers.SourceProvider is already registered. 2nd registration is being ignored. 2020-07-28 16:26:26,301 INFO [qtp1359044626-11] [org.gluu.oxauth.service.ApplicationFactory] (ApplicationFactory.java:82) - Cache configuration: CacheConfiguration{cacheProviderType=IN_MEMORY, memcachedConfiguration=MemcachedConfiguration{servers='localhost:11211', maxOperationQueueLength=100000, bufferSize=32768, defaultPutExpiration=60, connectionFactoryType=DEFAULT}, redisConfiguration=RedisConfiguration{servers='localhost:6379', defaultPutExpiration=60, redisProviderType=STANDALONE, useSSL=false, sslTrustStoreFilePath=}, inMemoryConfiguration=InMemoryConfiguration{defaultPutExpiration=60}, nativePersistenceConfiguration=NativePersistenceConfiguration [defaultPutExpiration=60, defaultCleanupBatchSize=25, baseDn=o=gluu]} 2020-07-28 16:26:34,893 INFO [qtp1359044626-17] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='6af0fb23-9b81-4c2b-8191-59c2d13f7f15', id='6af0fb23-9b81-4c2b-8191-59c2d13f7f15', lastUsedAt=Tue Jul 28 16:26:34 CDT 2020, userDn='inum=0000!6F53.3FE6,ou=people,o=gluu', authenticationTime=Tue Jul 28 16:26:34 CDT 2020, state=authenticated, sessionState='14e206a2bfddef265f003e98c1269741bbf9670bdc4b7424d69f2d33c22b5985.4f562252-24b0-4216-9526-b05395d83a7b', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@cda71d5, involvedClients=null, sessionAttributes={auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_external_attributes=null, opbs=b92027b1-dae8-4276-a718-c4063f9f97f0, auth_user=hicksje, scope=openid email user_name, response_type=code, redirect_uri=https://signon.caeservices.com/idp/Authn/oxAuth, state=eyJ0eXAiOiJKV1QiLCJhbGciOiJub25lIn0.eyJzdGF0ZSI6IjYycjJzcGJ5cnMiLCJjb252ZXJzYXRpb24iOiJlMXMxIn0., nonce=EP9mwjSnJJ, client_id=1101.5bde6525-0083-417e-9639-3b91d4630333}, persisted=true} 2020-07-28 16:26:34,894 INFO [qtp1359044626-17] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@4db5253e 2020-07-28 16:26:34,895 INFO [qtp1359044626-17] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'hicksje' 2020-07-28 16:26:35,395 INFO [qtp1359044626-19] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1101.5bde6525-0083-417e-9639-3b91d4630333' 2020-07-28 16:29:56,264 INFO [qtp1359044626-19] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:589) - Attempting to redirect user: SessionUser: SessionState {dn='3563c46b-4d5f-454e-98be-a0b8548f3df0', id='3563c46b-4d5f-454e-98be-a0b8548f3df0', lastUsedAt=Tue Jul 28 16:29:56 CDT 2020, userDn='inum=0000!8DB7.CCFC,ou=people,o=gluu', authenticationTime=Tue Jul 28 16:29:56 CDT 2020, state=authenticated, sessionState='cbb6a3a2bef77d454d33ac1d50711ae1436b4402ca4ed73ff8acbdafa89f8543.c512e0ee-f4d7-4ebd-8e2a-ea959b4c06e5', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=org.gluu.oxauth.model.common.SessionIdAccessMap@27a6d6ec, involvedClients=null, sessionAttributes={auth_external_attributes=null, opbs=41af403c-42d7-4095-a2db-639e2add5376, response_type=code, nonce=ba0a4a6a-11ec-4124-9109-fe85c2c97199, client_id=1001.7ecc44c8-d2bd-43cf-9079-419236c6a3e6, auth_step=1, acr=auth_ldap_server, remote_ip=192.168.3.22, auth_user=Administrator, scope=openid profile email user_name, acr_values=auth_ldap_server, redirect_uri=https://signon.caeservices.com/identity/authcode.htm, state=59657c5f-d580-4e8a-92e0-8fc14c5937de}, persisted=true} 2020-07-28 16:29:56,265 INFO [qtp1359044626-19] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:597) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@43aea58d 2020-07-28 16:29:56,267 INFO [qtp1359044626-19] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:426) - Authentication success for User: 'administrator' 2020-07-28 16:29:56,506 INFO [qtp1359044626-15] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:276) - Authentication success for Client: '1001.7ecc44c8-d2bd-43cf-9079-419236c6a3e6' 2020-07-28 16:30:32,730 INFO [metrics-reporter-1-thread-1] [org.gluu.oxauth.service.AppInitializer] (AppInitializer.java:363) - Created persistenceMetricEntryManager: org.gluu.persist.ldap.impl.LdapEntryManager@2878b874 with operation service: org.gluu.persist.ldap.operation.impl.LdapOperationsServiceImpl@613d19be```

By Mohit Mali staff 29 Jul 2020 at 4:29 a.m. CDT

Mohit Mali gravatar
Hi Jeremy Hicks, Can you please describe your issue in more detail. Thanks and Regards Mohit Mali

By Jeremy Hicks user 29 Jul 2020 at 8:52 a.m. CDT

Jeremy Hicks gravatar
I have some apache web apps that authenticate using the mod_auth_mellon plugin for Apache httpd. These apps look for the REMOTE_USER parameter. They do not authenticate correctly and show that the user login as a long string, for example, REMOTE_USER = AAdzZWNyZXQxwypwLNxGvYGHPp9bmFZFb+SytKUa9JEY3mCkI2ib2CGTzXvhSQ9uufeI37EJyS5q8EIwzMBZiyZ+hVV2/fIeTXZLBRgl3rmNdRr0K2BGZQPm5yevNEf+0LRJhCOYkS0wJA4V4qzMwXHXldi9xOkvwRHPiYp9 The value should be REMOTE_USER=username where username is the uid of the user I can see this by using a PHP page with the following code. <html> <head> <title>PHP Test</title> </head> <body> $key_value) { print $key_name . " = " . $key_value . "<br>"; } ?> </body> </html> This returns a long list of parameters, but REMOTE_USER and PHP_AUTH_USER show as REMOTE_USER = AAdzZWNyZXQxwypwLNxGvYGHPp9bmFZFb+SytKUa9JEY3mCkI2ib2CGTzXvhSQ9uufeI37EJyS5q8EIwzMBZiyZ+hVV2/fIeTXZLBRgl3rmNdRr0K2BGZQPm5yevNEf+0LRJhCOYkS0wJA4V4qzMwXHXldi9xOkvwRHPiYp9 and PHP_AUTH_USER = AAdzZWNyZXQxwypwLNxGvYGHPp9bmFZFb+SytKUa9JEY3mCkI2ib2CGTzXvhSQ9uufeI37EJyS5q8EIwzMBZiyZ+hVV2/fIeTXZLBRgl3rmNdRr0K2BGZQPm5yevNEf+0LRJhCOYkS0wJA4V4qzMwXHXldi9xOkvwRHPiYp9 I need to know what to do to correct this.

By Mohib Zico staff 03 Aug 2020 at 2:41 p.m. CDT

Mohib Zico gravatar
Hello Jeremy, Most probably it's "mod_auth_mellon" configuration though we don't know that plugin. I am suspecting you are doing a OIDC configuration with Gluu Server. In that case, we _officially_ support couple of plugins which are tested and proved working with Gluu Server. Lists are given in our documentation. We would love to test "mod_auth_mellon" but it might take some time. Thanks!