swa login slow with SOAP errors

[joaquindromero]

When logging into Scalix Web Access 9.2.0.212 (RHEL 3) using jakarta-5.0.28 the process is very slow. After approx 2 minutes an error pops up that reads: COULDNT FETCH MESSAGE: INBOX MESSAGE ID: UIDVALIDITY(1)2655. I can click ok on the error dialog box and continue on without any problems.

The scalix-swa_log reads as follows:

2005-06-20 02:03:24 StandardContext[/webmail]ip: 127.0.0.1; username: jromero; message: Could not write SOAP response: org.apache.catalina.connector.ClientAbortException: null
2005-06-20 02:48:02 StandardContext[/webmail]ip: 127.0.0.1; username: jromero; message: <SOAP-ENV:Fault><faultcode>SOAP-ENV:SERVER.SoapFault</faultcode><faultstring>couldn't fetch message: INBOX message id: UIDVALIDITY(1)2655

the entire message can be read at: http://www.x-idium.com/scalix-swa_log.2005-06-20.txt

I have j2sdk1.4.2_06 installed.

I can log into sac just fine. I have attempted a reconfigure of SWA through the installer; without success. Outlook client seems unaffected. This was working fine for a while then it just burped (can't think of any major changes made to mail server).

Thanks.

[ScalixSupport]

Can you try to access the mailbox using a standard IMAP client ?

UIDVALIDITY messages indicate that there is an issue with the mail data but we will need to understand whether it's a problem with SWA not understanding something or if it is a fundamental issue with IMAP.

Can you also check /var/opt/scalix/logs/fatal to see if there is any indication of an IMAP session abort ?

It may also be that tomcat needs to be restarted in case there is any possibility of a "corrupt" session.

Cheers

Dave

[joaquindromero]

Dave,

Thanks for looking into this for me.

IMAP works from a regular client like Evolution or Outlook/Outlook Express.

The following is from the fatal log:

SERIOUS ERROR IMAP Server Da(IMAP Server Pr) 06.24.05 17:09:54
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x27) [0xb75d9897]
/lib/tls/libpthread.so.0 [0xb74efdf8]
/opt/scalix/lib/libom_os.so(os_strdup+0x22) [0xb7570c62]
/opt/scalix/lib/libom_ual.so [0xb71d9f7a]
/opt/scalix/lib/libom_ual.so(ual_GetUsersHost+0xb7) [0xb71da506]
/opt/scalix/lib/libom_ual.so(ual_GetFreeBusyTime+0x110) [0xb71da6aa]
/opt/scalix/lib/libom_ual.so(ual_RecvReply+0xcac) [0xb71949a4]
/opt/scalix/lib/libom_tucl.so(uall_read+0x174) [0xb754258b]
/opt/scalix/lib/libom_tucl.so(ual_recv+0x32) [0xb753ec9d]
in.imap41d [0x806a6a5]
User Name: Joaquin D. Romero / mail, x-idium/CN=Joaquin D. Romero
Pid of logging process: 22483


the whole log is at http://www.x-idium.com/fatal

I have restarted Tomcat and even rebooted.

Thanks again.
JRomero

[ScalixSupport]

Reference to

Code: Select all

 -> ual_GetUsersHost

just before the abort gives us an avenue for troubleshooting.

Can you run the command

Code: Select all

omresetmn

. This will clear out the current mapping between the mailbox and a server name. This mapping gets built automatically so you should then attempt another sign-in.

Cheers

Dave

[joaquindromero]

Dave,

Ran omrestmn and tried login again... still slow with error.

fatal has following entry:

ERROR Administration(ommodmn ) 06.24.05 19:14:19
[OM 5707] No matching entry found in mailnode mapping file
Pid of logging process: 23125


SERIOUS ERROR Administration(ommodmn ) 06.24.05 19:14:19
[OM 5707] No matching entry found in mailnode mapping file
Pid of logging process: 23125


I want to seem like I'm contributing so here goes... Is this a hostname or administrator account name thing?

Thanks!

JRomero

[ScalixSupport]

It looks like we may have seen this problem before but we haven't been able to reproduce the cause.

We want to get to the bottom of this so I need to ask you a load of questions...

Did this start after an upgrade or was there a specific action that caused this to start happening ?

Is this one user that is affected or all of them ?

Although this issue has not been fixed in 9.2.1, it might be worth upgrading to that and testing again.

Cheers

Dave

[joaquindromero]

Dave,

I cant put my finger on any major event that coincides with this.

It effects everyone.

I upgraded to 9.2.1 and it looks promising. No more long wait and uid error. Thats good!

Problem is when I try to send i get UNABLE TO SEND MAIL TO: error dialog when I click on send. I can send intradomain mail fine. The problem is when I try to send to any other domain. Outlook Client works fine. Logs indicate spam filter problem:

2005-06-28 11:18:44 StandardContext[/webmail]ip: 192.168.0.2; username: jromero; message: SMTP send: Unable to send message to one or more addresses

javax.mail.SendFailedException: Invalid Addresses;
nested exception is:
class javax.mail.SendFailedException: 550 Denied due to spam list

at com.sun.mail.smtp.SMTPTransport.rcptTo(SMTPTransport.java:926)
at com.sun.mail.smtp.SMTPTransport.sendMessage(SMTPTransport.java:389)
at com.oddpost.server.module.SoapMail.sendMessage(SoapMail.java:1708)
at com.oddpost.server.module.SoapMail.send(SoapMail.java:870)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:324)
at com.oddpost.soap.SoapModule.invokeMethod(SoapModule.java:238)
at com.oddpost.soap.SoapRequestImpl.execute(SoapRequestImpl.java:140)
at com.oddpost.server.HttpRequestHandler.handleRequest(HttpRequestHandler.java:221)
at com.oddpost.server.SoapServlet.doPost(SoapServlet.java:50)
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 com.oddpost.server.filter.HttpConfFilter.doFilter(HttpConfFilter.java:175)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:186)
... skipping the last 25 lines as irrelevant...

2005-06-28 11:18:45 StandardContext[/webmail]ip: 192.168.0.2; username: jromero; message: <SOAP-ENV:Fault><faultcode>SOAP-ENV:SERVER.SomeRecipientsRefused</faultcode><faultstring>Unable to send mail to:

joaquindromero@yahoo.com</faultstring><detail><e:SomeRecipientsRefused xmlns:e="http://scalix.com/errors"><message>Unable to send mail to:

joaquindromero@yahoo.com</message><debug>[none]</debug></e:SomeRecipientsRefused></detail></SOAP-ENV:Fault>


We're getting closer!!!!

Thanks

[ScalixSupport]

"Denied due to spam list" is an error returned by the SMTP Relay when the sender's domain (either mail address or connecting IP address) doesn't pass the RELAY accept or RELAY reject rules that are in /var/opt/scalix/sys/smtpd.cfg.

Take a look at the mail address that is being used to send the messages from and also the IP address of the connecting server, which is going to be the same server as the Scalix installation.

Can you post the relevant lines from the smtpd.cfg file (mask the genuine details if you want to) and a sample sender mail address ?


Cheers

Dave