Can't login to SWA or SAC, again!

Discuss the Scalix Server software

Moderators: ScalixSupport, admin

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Can't login to SWA or SAC, again!

Postby mito » Wed Jun 21, 2006 10:41 am

Hello, it's me again.

I just got done dealing with a big problem on this thread:
http://www.scalix.com/community/viewtopic.php?t=2760

And it apeared that everything was working well. I was doing some testing etc, and I was able to both send and receive mail from SWA, manage things via SAC, etc. Then I tried to use my pop3 client, and I was able to receive mail perfectly fine as I had been able to before. Then I tried to send mail using my client, and I wasn't able to send mail at all, it was as if the server was locking up on the smtp request or something. So then I logged into SWA again to test, and yet again I was able to both send and receive with SWA.

Then I realized that I hadn't rebooted this server since I solved the problem in my last thread, so I rebooted both my router and my server. Now, ever since I did that, I'm unable to connect to the mail server via pop3 or smtp now. So i tried SWA, and I get a popup message saying:
Cannot connect to the mail server mail.domain.com!
The mail server on mail.domain.com appears to be down.


When I try to login to SAC it says:
Could Not login
The administration server is not responding.
You should check the server log files.


I checked the forums, suggestions have been to check several things, and I checked the ones I saw. what I checked are:
/opt/scalix-tomcat/bin/setclasspath.sh - the lines were added to the top as was supposed to be.

ps -aef|grep httpd - httpd is running
ps -aef|grep tomcat - tomcat is running

lsof -i:80 - http is listening on port 80
lsof -i:8009 - localhost.localdomain is listening on several ports, including 8009

I can ping mail.domain.com and it responds properly.

Any suggestions?
Thanks again!
Mito

ScalixSupport
Scalix
Scalix
Posts: 5503
Joined: Thu Mar 25, 2004 8:15 pm

Postby ScalixSupport » Wed Jun 21, 2006 11:00 am

Hi,

as in the previous post, please post all logfiles again that we had asked you in the other thread. Also, is this box on a dhcp network?

Cheers,

Sascha.

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 11:05 am

Here's the last 150 lines of caa.log

Code: Select all

[root@scalix logs]# tail -n 150 /opt/scalix-tomcat/logs/caa.log
2006-06-21 10:50:58,690  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 44 mins, 55 secs
2006-06-21 10:51:13,781  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:51:58,697  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 45 mins, 55 secs
2006-06-21 10:52:13,788  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:52:58,705  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 46 mins, 55 secs
2006-06-21 10:53:13,796  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:53:58,713  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 47 mins, 55 secs
2006-06-21 10:54:13,803  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:54:58,721  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 48 mins, 55 secs
2006-06-21 10:55:13,811  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:55:58,728  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 49 mins, 55 secs
2006-06-21 10:56:13,823  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:56:58,736  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 50 mins, 55 secs
2006-06-21 10:57:13,827  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:57:58,744  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 51 mins, 55 secs
2006-06-21 10:58:13,834  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:58:21,111 ERROR [LDAPHelperUtils.getTargetHost:362] javax.naming.CommunicationException: mail.domain.com:389 [Root exception is java.net.ConnectException: Connection refused]
2006-06-21 10:58:21,134 ERROR [RbacAuthorizationHelper.authenticateUser:87] Exception:
javax.naming.CommunicationException: mail.domain.com:389 [Root exception is java.net.ConnectException: Connection refused]
        at com.sun.jndi.ldap.Connection.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapClient.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapClient.getInstance(Unknown Source)
        at com.sun.jndi.ldap.LdapCtx.connect(Unknown Source)
        at com.sun.jndi.ldap.LdapCtx.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getUsingURL(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getUsingURLs(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getLdapCtxInstance(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getInitialContext(Unknown Source)
        at javax.naming.spi.NamingManager.getInitialContext(Unknown Source)
        at javax.naming.InitialContext.getDefaultInitCtx(Unknown Source)
        at javax.naming.InitialContext.init(Unknown Source)
        at javax.naming.InitialContext.<init>(Unknown Source)
        at javax.naming.directory.InitialDirContext.<init>(Unknown Source)
        at com.scalix.sac.ubermgr.ldap.LDAPQuery.initContext(LDAPQuery.java:71)
        at com.scalix.sac.ubermgr.rbac.RbacAuthorizationHelper.authenticateUser(RbacAuthorizationHelper.java:58)
        at com.scalix.sac.ubermgr.ldap.LDAPServiceHandler.Login(LDAPServiceHandler.java:112)
        at com.scalix.sac.ubermgr.caa.RESService.authenticateAndAuthorizeUser(RESService.java:157)
        at com.scalix.sac.ubermgr.caa.RESService.doRequest(RESService.java:83)
        at com.scalix.caa.soap.SOAPDispatcherServlet.onMessage(SOAPDispatcherServlet.java:267)
        at com.scalix.caa.soap.SAAJServlet.doPost(SAAJServlet.java:123)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:709)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:237)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:157)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:214)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardContextValve.invokeInternal(StandardContextValve.java:198)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:152)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:137)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:118)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:929)
        at org.apache.coyote.tomcat5.CoyoteAdapter.service(CoyoteAdapter.java:160)
        at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:300)
        at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:374)
        at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:743)
        at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:675)
        at org.apache.jk.common.SocketConnection.runIt(ChannelSocket.java:866)
        at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:683)
        at java.lang.Thread.run(Unknown Source)
Caused by: java.net.ConnectException: Connection refused
        at java.net.PlainSocketImpl.socketConnect(Native Method)
        at java.net.PlainSocketImpl.doConnect(Unknown Source)
        at java.net.PlainSocketImpl.connectToAddress(Unknown Source)
        at java.net.PlainSocketImpl.connect(Unknown Source)
        at java.net.SocksSocketImpl.connect(Unknown Source)
        at java.net.Socket.connect(Unknown Source)
        at java.net.Socket.connect(Unknown Source)
        at java.net.Socket.<init>(Unknown Source)
        at java.net.Socket.<init>(Unknown Source)
        at com.sun.jndi.ldap.Connection.createSocket(Unknown Source)
        ... 49 more
2006-06-21 10:58:58,768  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 52 mins, 55 secs
2006-06-21 10:59:13,842  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 10:59:58,775  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 53 mins, 55 secs
2006-06-21 11:00:13,850  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
2006-06-21 11:00:58,783  INFO [RESMonitor.run:115] Server mail.domain.com up 9 hrs, 54 mins, 55 secs
2006-06-21 11:01:08,530 ERROR [LDAPHelperUtils.getTargetHost:362] javax.naming.CommunicationException: mail.domain.com:389 [Root exception is java.net.ConnectException: Connection refused]
2006-06-21 11:01:08,532 ERROR [RbacAuthorizationHelper.authenticateUser:87] Exception:
javax.naming.CommunicationException: mail.domain.com:389 [Root exception is java.net.ConnectException: Connection refused]
        at com.sun.jndi.ldap.Connection.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapClient.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapClient.getInstance(Unknown Source)
        at com.sun.jndi.ldap.LdapCtx.connect(Unknown Source)
        at com.sun.jndi.ldap.LdapCtx.<init>(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getUsingURL(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getUsingURLs(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getLdapCtxInstance(Unknown Source)
        at com.sun.jndi.ldap.LdapCtxFactory.getInitialContext(Unknown Source)
        at javax.naming.spi.NamingManager.getInitialContext(Unknown Source)
        at javax.naming.InitialContext.getDefaultInitCtx(Unknown Source)
        at javax.naming.InitialContext.init(Unknown Source)
        at javax.naming.InitialContext.<init>(Unknown Source)
        at javax.naming.directory.InitialDirContext.<init>(Unknown Source)
        at com.scalix.sac.ubermgr.ldap.LDAPQuery.initContext(LDAPQuery.java:71)
        at com.scalix.sac.ubermgr.rbac.RbacAuthorizationHelper.authenticateUser(RbacAuthorizationHelper.java:58)
        at com.scalix.sac.ubermgr.ldap.LDAPServiceHandler.Login(LDAPServiceHandler.java:112)
        at com.scalix.sac.ubermgr.caa.RESService.authenticateAndAuthorizeUser(RESService.java:157)
        at com.scalix.sac.ubermgr.caa.RESService.doRequest(RESService.java:83)
        at com.scalix.caa.soap.SOAPDispatcherServlet.onMessage(SOAPDispatcherServlet.java:267)
        at com.scalix.caa.soap.SAAJServlet.doPost(SAAJServlet.java:123)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:709)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:237)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:157)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:214)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardContextValve.invokeInternal(StandardContextValve.java:198)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:152)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:137)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:118)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:102)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
        at org.apache.catalina.core.StandardValveContext.invokeNext(StandardValveContext.java:104)
        at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:520)
        at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:929)
        at org.apache.coyote.tomcat5.CoyoteAdapter.service(CoyoteAdapter.java:160)
        at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:300)
        at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:374)
        at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:743)
        at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:675)
        at org.apache.jk.common.SocketConnection.runIt(ChannelSocket.java:866)
        at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:683)
        at java.lang.Thread.run(Unknown Source)
Caused by: java.net.ConnectException: Connection refused
        at java.net.PlainSocketImpl.socketConnect(Native Method)
        at java.net.PlainSocketImpl.doConnect(Unknown Source)
        at java.net.PlainSocketImpl.connectToAddress(Unknown Source)
        at java.net.PlainSocketImpl.connect(Unknown Source)
        at java.net.SocksSocketImpl.connect(Unknown Source)
        at java.net.Socket.connect(Unknown Source)
        at java.net.Socket.connect(Unknown Source)
        at java.net.Socket.<init>(Unknown Source)
        at java.net.Socket.<init>(Unknown Source)
        at com.sun.jndi.ldap.Connection.createSocket(Unknown Source)
        ... 49 more
2006-06-21 11:01:13,858  INFO [NotificationEventListener$WorkerThread.run:50] Event Notification: heartbeat|http://mail.domain.com/res/RESDispatcher|LISTEN|300|mail|mail.domain.com|10.0.1 from host:mail.domain.com
[root@scalix logs]#


looks like possibly some kind of java exception, but why that would have changed I don't know...

Oh, and this is not a DHCP network. All IP's (just this machine and the router actually) are static, with no dhcp server running.
Last edited by mito on Wed Jun 21, 2006 11:53 am, edited 1 time in total.

ScalixSupport
Scalix
Scalix
Posts: 5503
Joined: Thu Mar 25, 2004 8:15 pm

Postby ScalixSupport » Wed Jun 21, 2006 11:08 am

The connection on port 389 was refused, so ldap is not running.

Please do omstat -a and look for LDAP Daemon.

Best case, omon ldap should do it.

Cheers,

Sascha.

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 11:12 am

Wow, should all these things really be aborted?

Code: Select all

# omstat -a
PC Monitor                    Aborted        NON-STOP       0
Directory Relay Server        Aborted        00:55:35
Notification Server           Aborted        00:55:35       0
Shared memory daemon          Aborted        NON-STOP
Notification Monitor          Aborted        NON-STOP
Session Monitor               Aborted        NON-STOP
Container Access Monitor      Aborted        NON-STOP
Item Structure Server         Stopped
Database Monitor              Aborted        00:55:35
Licence Monitor Daemon        Aborted        NON-STOP
LDAP Daemon                   Aborted        00:55:35
Queue Manager                 Aborted        NON-STOP
Item Delete Daemon            Aborted        NON-STOP
IMAP Server Daemon            Aborted        00:55:35
SMTP Relay                    Aborted        00:55:35
Mime Browser Controller       Aborted        00:55:35

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 11:16 am

Strangely, I tried some things, based on the fact that everything was aborted, and this is what transpired:

Code: Select all

# service scalix restart
Starting Scalix services (mail): /opt/scalix/bin/omrc : Scalix appears to be running.
If you wish to restart Scalix cleanly, run "omshut" or
kill the following processes, then run "omrc".

[FAILED]
# omshut
omoff : [OM 4835] Subsystem Application Link Server is already off.
Disabling 14 subsystem(s).
omoff : [OM 4835] Subsystem Item Structure Server is already off.
Disabling 7 subsystem(s).
# service scalix restart
Starting Scalix services (mail): Enabling 7 subsystem(s).
Enabling 14 subsystem(s).
/opt/scalix/bin/omrc : Scalix started

[  OK  ]
#


Then I tried to access my SAC and SWA, and they worked.
This is strange though, as before I rebooted the server (something that I forgot to mention) I did try a 'service scalix restart' and it didn't do any good. Now I will try to send through outlook...
Last edited by mito on Wed Jun 21, 2006 11:53 am, edited 1 time in total.

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 11:44 am

Ok, so I tested my outgoing and incoming mail again, both with SWA and using outlook as a pop3 client, and everything worked. Then I was confused, thinking... why did this happen on a fresh boot?

So I rebooted the server, just to make sure that everything would work on the next time that it boots, and sure enough, it doesn't. I'm getting the same errors as before, and when I do an 'omstat -a' it tells me that all the services are stopped or aborted just like in my post above.

Any ideas where to look to find out why it's doing this on startup?

Mito

Edit: I just tried the cmd 'chkconfig --level 345 scalix on' and rebooted, we'll see how that works...

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 11:51 am

It worked that time, so apparently the scalix service wasn't set to startup automatically by the installer?

In any case, it's set to install now, just was confusing as I had just expected that it would be set to startup automatically, not sure why it wasn't.

thanks again!

Mito

ScalixSupport
Scalix
Scalix
Posts: 5503
Joined: Thu Mar 25, 2004 8:15 pm

Postby ScalixSupport » Wed Jun 21, 2006 5:18 pm

Hi,

What OS is this machine running?

Thanks,
Yuri

mito
Posts: 194
Joined: Fri Mar 24, 2006 11:33 am

Postby mito » Wed Jun 21, 2006 10:06 pm

ScalixSupport wrote:Hi,

What OS is this machine running?

Thanks,
Yuri


Fedora Core 4

As I said though, I did get it working, and it did install the service as auto-startup in the original install, just not the uninstall/reinstall.

Also, I checked my services listing via the 'setup' command, and scalix doesn't even show as a valid service, yet all the 'service scalix restart' command etc work properly.

Mito


Return to “Scalix Server”



Who is online

Users browsing this forum: No registered users and 2 guests

cron