SAC was working, now can't login
Posted: Tue Aug 07, 2007 3:09 pm
I have been using SAC, webmail, etc. for about a month or two with no problems. However, now I can't get into SAC! I really can't think of a single change that has been made to the server since I first got it up and running.
So, after scouring the forums for any solutions, and trying about three or four of them, I am at a dead end.
I have verified all my ports (I am using 11. something past the RC's.... the scalix-installer set up the apache proxy stuff for tomcat, etc.... no problem until now) and I've verified my usernames. sxqueryadmin exists and has the right password, my mail administrator (not sxadmin, but mailadmin) is correct and has the right password. Also, webmail works wonderful still, as does pop3, smtp, imap, etc. etc. JUST the SAC doesn't work!
When I try to login to the SAC I get: "Could Not Login, Could not fetch configuration information. Possible problem with administration server"
So, here's 100 lines from my /var/opt/scalix/m2/tomcat/logs/scalix-caa.log (already in debug mode).
While it isn't life or death to get this figured out (I have gotten to be pretty good with the om commands) I would REALLY like it!
So, after scouring the forums for any solutions, and trying about three or four of them, I am at a dead end.
I have verified all my ports (I am using 11. something past the RC's.... the scalix-installer set up the apache proxy stuff for tomcat, etc.... no problem until now) and I've verified my usernames. sxqueryadmin exists and has the right password, my mail administrator (not sxadmin, but mailadmin) is correct and has the right password. Also, webmail works wonderful still, as does pop3, smtp, imap, etc. etc. JUST the SAC doesn't work!
When I try to login to the SAC I get: "Could Not Login, Could not fetch configuration information. Possible problem with administration server"
So, here's 100 lines from my /var/opt/scalix/m2/tomcat/logs/scalix-caa.log (already in debug mode).
Code: Select all
2007-08-07 14:02:29,757 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header user-agent:Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.1.5) Gecko/20070718 Fedora/2.0.0.5-1.fc7 Firefox/2.0.0.5
2007-08-07 14:02:29,757 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header accept:text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5
2007-08-07 14:02:29,758 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header accept-language:en-us,en;q=0.5
2007-08-07 14:02:29,758 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header accept-encoding:gzip,deflate
2007-08-07 14:02:29,758 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header accept-charset:ISO-8859-1,utf-8;q=0.7,*;q=0.7
2007-08-07 14:02:29,759 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header Keep-Alive:300
2007-08-07 14:02:29,759 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header connection:keep-alive
2007-08-07 14:02:29,759 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header content-type:text/xml
2007-08-07 14:02:29,760 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header referer:https://scalix.mydomain.com/sac/AdminApp.jsp
2007-08-07 14:02:29,760 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header content-length:435
2007-08-07 14:02:29,760 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header cookie:opPrefs=wl_null%3A0%26wt_null%3A3%26btph_jmason%3A200%26wl_jmason%3A0%26wt_jmason%3A3%26ww_jmason%3A1680%26wh_jmason%3A922%26ww_scalixadmin%3A931%26wh_scalixadmin%3A541%26wl_scalixadmin%3A86%26wt_scalixadmin%3A306; OPENscalix_USER=scalixadmin(32)(47)scalix(47)CN(61)Administrator; mws_login=6da3980d6c0e1e2be10341d9c2dc187f1fbfa52a6ce4f49d66e7cc7ff9780e24
2007-08-07 14:02:29,761 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header pragma:no-cache
2007-08-07 14:02:29,761 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header Cache-Control:no-cache
2007-08-07 14:02:29,761 DEBUG [SAAJUtils.dumpHeaders:129] -----> Header Max-Forwards:10
2007-08-07 14:02:29,795 DEBUG [SOAPDispatcherServlet.onMessage:159] **** Start of Message Handling ****
2007-08-07 14:02:29,797 DEBUG [SOAPHelper.getElementValue:144] Found ServiceType
2007-08-07 14:02:29,798 DEBUG [CAAConfigLoader.getValue:56] Looking for config for scalix.res, key disabled found null
2007-08-07 14:02:29,798 DEBUG [SOAPHelperUtils.getSoapBodyElement:179] Body element1 CAARequestMessage = null
2007-08-07 14:02:29,798 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 ServiceType = scalix.res
2007-08-07 14:02:29,799 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 Credentials = null
2007-08-07 14:02:29,799 DEBUG [SOAPHelperUtils.getSoapBodyElement:190] Found Credentials
2007-08-07 14:02:29,799 DEBUG [SOAPHelperUtils.getCredentials:255] local name=id
2007-08-07 14:02:29,800 DEBUG [SOAPHelperUtils.getCredentials:256] qualified name=id
2007-08-07 14:02:29,800 DEBUG [SOAPHelperUtils.getCredentials:272] local name=name
2007-08-07 14:02:29,800 DEBUG [SOAPHelperUtils.getCredentials:273] qualified name=name
2007-08-07 14:02:29,801 DEBUG [SOAPHelperUtils.getCredentials:277] value=scalixadmin
2007-08-07 14:02:29,801 DEBUG [SOAPHelperUtils.getCredentials:272] local name=passwd
2007-08-07 14:02:29,801 DEBUG [SOAPHelperUtils.getCredentials:273] qualified name=passwd
2007-08-07 14:02:29,802 DEBUG [SOAPHelperUtils.getCredentials:282] value=xxxxxxxxx
2007-08-07 14:02:29,802 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:69] Body element1 CAARequestMessage = null
2007-08-07 14:02:29,802 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 ServiceType = scalix.res
2007-08-07 14:02:29,803 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 Credentials = null
2007-08-07 14:02:29,803 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 FunctionName = GetscalixNodesList
2007-08-07 14:02:29,803 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:80] Found FunctionName
2007-08-07 14:02:29,804 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:81] value =GetscalixNodesList
2007-08-07 14:02:29,804 DEBUG [SOAPHelperUtils.getSoapBodyElement:179] Body element1 CAARequestMessage = null
2007-08-07 14:02:29,805 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 ServiceType = scalix.res
2007-08-07 14:02:29,805 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 Credentials = null
2007-08-07 14:02:29,805 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 FunctionName = GetscalixNodesList
2007-08-07 14:02:29,806 DEBUG [SOAPHelperUtils.getSoapBodyElement:187] Body element2 GetscalixNodesListParameters = null
2007-08-07 14:02:29,806 DEBUG [SOAPHelperUtils.getSoapBodyElement:200] No SoapBodyElement of type ScalixServers found.
2007-08-07 14:02:29,806 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:69] Body element1 CAARequestMessage = null
2007-08-07 14:02:29,807 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 ServiceType = scalix.res
2007-08-07 14:02:29,807 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:80] Found ServiceType
2007-08-07 14:02:29,807 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:81] value =scalix.res
2007-08-07 14:02:29,808 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:69] Body element1 CAARequestMessage = null
2007-08-07 14:02:29,808 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 ServiceType = scalix.res
2007-08-07 14:02:29,808 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 Credentials = null
2007-08-07 14:02:29,809 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:77] Body element2 FunctionName = GetscalixNodesList
2007-08-07 14:02:29,809 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:80] Found FunctionName
2007-08-07 14:02:29,809 DEBUG [SOAPHelperUtils.getSOAPBodyElementValue:81] value =GetscalixNodesList
2007-08-07 14:02:29,811 DEBUG [CAAServiceFactory.getService:52] Looking for service called scalix.res
2007-08-07 14:02:29,811 DEBUG [CAAConfigLoader.getValue:56] Looking for config for scalix.res, key service.class found com.scalix.sac.ubermgr.caa.RESService
2007-08-07 14:02:29,812 DEBUG [SOAPDispatcherServlet.onMessage:266] Calling doRequest() on service com.scalix.sac.ubermgr.caa.RESService@508be
2007-08-07 14:02:29,812 DEBUG [CAAConfigLoader.getValue:56] Looking for config for scalix.res, key connection.mode found 1
2007-08-07 14:02:29,813 DEBUG [CAAConnectionManager.getConnection:71] Connection mode is 1
2007-08-07 14:02:29,813 DEBUG [CAAConfigLoader.getValue:56] Looking for config for scalix.res, key connection.configurator.class found com.scalix.caa.framework.CAAConnectionPoolManager
2007-08-07 14:02:29,813 DEBUG [CAAConnectionPoolManager.logConnectionPool:315] Connection pool scalix.res status: min=2,max=10,size=2,used=0
2007-08-07 14:02:29,814 DEBUG [CAAConnectionPoolManager.getFreeConnectionFromPool:129] Looking at connection 0
2007-08-07 14:02:29,814 DEBUG [CAAConnectionPoolManager.getFreeConnectionFromPool:146] Found a free connection (0) for scalix.res and endpoint http://scalix.mydomain.com/res/RESDispatcher
2007-08-07 14:02:29,815 DEBUG [CAAConnectionPoolManager.getFreeConnectionFromPool:199] Retrieved connection from pool for scalix.res and endpoint http://scalix.mydomain.com/res/RESDispatcher
2007-08-07 14:02:29,815 DEBUG [CAAConnectionPoolManager.logConnectionPool:315] Connection pool scalix.res status: min=2,max=10,size=2,used=1
2007-08-07 14:02:29,816 DEBUG [ConnectionHelperUtils.sendAndReceiveMessage:162] System is not configured to talk to scalix.mydomain.com securely, OK
2007-08-07 14:02:29,818 FATAL [RESServiceHandler.GetscalixNodesList:965] java.io.FileNotFoundException: http://scalix.mydomain.com/res/RESDispatcher:scalix.mydomain.com
java.io.FileNotFoundException: http://scalix.mydomain.com/res/RESDispatcher
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
at java.net.URLConnection.getContent(Unknown Source)
at com.scalix.sac.ubermgr.caa.RESConnection.receiveMessage(RESConnection.java:114)
at com.scalix.sac.ubermgr.util.ConnectionHelperUtils.sendAndReceiveMessage(ConnectionHelperUtils.java:166)
at com.scalix.sac.ubermgr.res.RESServiceHandler.GetscalixNodesList(RESServiceHandler.java:948)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.scalix.sac.ubermgr.caa.RESService.doRequest(RESService.java:109)
at com.scalix.caa.soap.SOAPDispatcherServlet.onMessage(SOAPDispatcherServlet.java:268)
at com.scalix.caa.soap.SAAJServlet.doPost(SAAJServlet.java:123)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:710)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:803)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:210)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:174)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:151)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:200)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:283)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:773)
at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:703)
at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:895)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:685)
at java.lang.Thread.run(Unknown Source)
2007-08-07 14:02:29,819 DEBUG [CAAConnectionPoolManager.freeConnection:88] Freeing a connection
2007-08-07 14:02:29,819 DEBUG [CAAConnectionPoolManager.logConnectionPool:315] Connection pool scalix.res status: min=2,max=10,size=2,used=0
2007-08-07 14:02:29,819 ERROR [GetscalixNodesList.buildResponseMessage:104] Skipping server scalix.mydomain.com. No document received!
2007-08-07 14:02:29,822 DEBUG [SAAJServlet.doPost:130] ************ Request End Success ***************
2007-08-07 14:03:02,119 DEBUG [RESMonitor.run:67] There are 1 remote servers registered
2007-08-07 14:03:02,120 INFO [RESMonitor.run:115] Server scalix.mydomain.com up 4 mins, 58 secs
While it isn't life or death to get this figured out (I have gotten to be pretty good with the om commands) I would REALLY like it!