HTTP Status 400 - Invalid path /Authorization was requested
From time to time, we have users that receive a Tomcat error code upon login. The message says "HTTP Status 400 - Invalid path /Authorization was requested". Once a user begins seeing this message, they cannot log in until I purge their user from the table aaauser--of course, a big side-effect of this is that when a user has been purged, so are their secret questions. I've been trying to establish a pattern to these problems, but have been unsuccessful.
The following log entries seem relevant:
The following log entries seem relevant:
[14:46:06:874]|[09-05-2008]|[com.adventnet.authentication.lm.Authenticator]|[INFO]|[28]|: Authentication Log Message : ######## - AuthenticateUser : LogonUser O/p (0x8009030c) |
[14:46:06:874]|[09-05-2008]|[com.adventnet.authentication.lm.Authenticator]|[INFO]|[28]|: Authentication Log Message : ######## - AuthenticateUser : ADsOpenObject O/p (0x0) |
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: java.lang.NullPointerException|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.sym.adsm.common.server.admin.authentication.ADMPRoleHandler.getRoleIdForUser(ADMPRoleHandler.java:224)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.sym.adsm.common.server.admin.authentication.ADMPRoleHandler.getAAADetails(ADMPRoleHandler.java:297)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.sym.adsm.common.server.admin.authentication.ADMPADAuthenticator.authenticate(ADMPADAuthenticator.java:201)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.authentication.lm.Authenticator.login(Authenticator.java:84)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at java.lang.reflect.Method.invoke(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at javax.security.auth.login.LoginContext.invoke(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at javax.security.auth.login.LoginContext.access$000(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at javax.security.auth.login.LoginContext$4.run(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at java.security.AccessController.doPrivileged(Native Method)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at javax.security.auth.login.LoginContext.invokePriv(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at javax.security.auth.login.LoginContext.login(Unknown Source)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.authentication.internal.PAMImpl.validate(PAMImpl.java:42)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.authentication.PAM.login(PAM.java:66)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at com.adventnet.authentication.realm.CustomJAASRealm.authenticate(CustomJAASRealm.java:66)|
[14:46:07:046]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.authenticator.CustomFormAuthenticator.authenticate(CustomFormAuthenticator.java:280)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:446)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:137)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:118)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:535)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.authenticator.SingleSignOn.invoke(SingleSignOn.java:417)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:929)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.coyote.tomcat5.CoyoteAdapter.service(CoyoteAdapter.java:160)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:799)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.processConnection(Http11Protocol.java:705)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.tomcat.util.net.TcpWorkerThread.runIt(PoolTcpEndpoint.java:577)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:683)|
[14:46:07:093]|[09-05-2008]|[SYSOUT]|[INFO]|[28]|: at java.lang.Thread.run(Unknown Source)|
[14:46:07:093]|[09-05-2008]|[com.adventnet.authentication.lm.AccountValidator]|[SEVERE]|[28]|: principal obj is null, commit failed|
[14:46:07:312]|[09-05-2008]|[com.adventnet.authentication.PAM]|[INFO]|[28]|: Credential obtained after authentication : Credential : [
UserId : 1109
LoginId : 1109
AccountId : 1109
SessionId : 21939
LocaleId : -1
LoginName : ########
ServiceName : System
HostName : 10.3.0.65
UserRoles : [DomainUser, AccessAllMethods, AccessAllTables]
TimeZone : sun.util.calendar.ZoneInfo[id="America/New_York",offset=-18000000,dstSavings=3600000,useDaylight=true,transitions=235,lastRule=java.util.SimpleTimeZone[id=America/New_York,offset=-18000000,dstSavings=3600000,useDaylight=true,startYear=0,startMode=3,startMonth=2,startDay=8,startDayOfWeek=1,startTime=7200000,startTimeMode=0,endMode=3,endMonth=10,endDay=1,endDayOfWeek=1,endTime=7200000,endTimeMode=0]]
Locale : en_US]|
[14:46:07:312]|[09-05-2008]|[com.adventnet.authentication.realm.CustomJAASRealm]|[INFO]|[28]|: successfully authenticated user : ######## in : 469ms|
[14:46:07:859]|[09-05-2008]|[org.apache.struts.action.RequestProcessor]|[SEVERE]|[40]|: Invalid path /Authorization was requested|