Announcement

Collapse
No announcement yet.

sieve server error with version 6.10

Collapse
X
 
  • Filter
  • Time
  • Show
Clear All
new posts

  • sieve server error with version 6.10

    dear volks,

    i have two ox-servers running; an old one: Build 6.8.0-6802
    and now a second one: Version: 6.10.0 Rev6 (2009-07-19 18:13:40)

    version 6.8 seems to be fine with my external cyrus-mailservers sieve configuration but the new one tells me that there is something wrong (but also telnet at port 2000 establishes a connection to the imap server):

    05.08.2009 13:05-->Fehlermeldung: Error in low level connection to sieve server (MAIL_FILTER-0014, 1350036445-1043)

    treads in the old forum suggest to disable the mailfilter bundle (http://sdb.open-xchange.com/node/66) . any other ideas?

    great thanks and best regards,
    mnu

    here are the logs:
    Code:
    Aug 5, 2009 1:05:21 PM com.openexchange.authentication.imap.impl.IMAPAuthentication handleLoginInfo
    INFO: Imap authentication for user xyz successful on host imap.xyz.at:143
    Aug 5, 2009 1:05:21 PM com.openexchange.sessiond.impl.SessionHandler addSession
    INFO: Session created. ID: d7af39218c90426fa2cf6d30b0d4d74f, Context: 1, User: 3
    Aug 5, 2009 1:05:52 PM com.openexchange.mailfilter.ajax.AJAXServlet doGet
    SEVERE: MAIL_FILTER-0014 Category=8 Message=Error in low level connection to sieve server exceptionID=1350036445-1043
    MAIL_FILTER-0014 Category=8 Message=Error in low level connection to sieve server exceptionID=1350036445-1043
    	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionConfig(MailfilterAction.java:167)
    	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionConfig(MailfilterAction.java:97)
    	at com.openexchange.mailfilter.ajax.actions.AbstractAction.action(AbstractAction.java:79)
    	at com.openexchange.mailfilter.ajax.AJAXServlet.doGet(AJAXServlet.java:191)
    	at javax.servlet.http.HttpServlet.service(HttpServlet.java:596)
    	at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
    	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.doServletService(AJPv13RequestHandlerImpl.java:429)
    	at com.openexchange.ajp13.AJPv13Request.response(AJPv13Request.java:128)
    	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.createResponse(AJPv13RequestHandlerImpl.java:282)
    	at com.openexchange.ajp13.najp.AJPv13ConnectionImpl.createResponse(AJPv13ConnectionImpl.java:189)
    	at com.openexchange.ajp13.najp.AJPv13Task.run(AJPv13Task.java:258)
    	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:417)
    	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:269)
    	at java.util.concurrent.FutureTask.run(FutureTask.java:123)
    	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
    	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
    	at java.lang.Thread.run(Thread.java:595)
    Caused by: java.net.SocketTimeoutException: Read timed out
    	at java.net.SocketInputStream.socketRead0(Native Method)
    	at java.net.SocketInputStream.read(SocketInputStream.java:129)
    	at sun.nio.cs.StreamDecoder$CharsetSD.readBytes(StreamDecoder.java:411)
    	at sun.nio.cs.StreamDecoder$CharsetSD.implRead(StreamDecoder.java:453)
    	at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:183)
    	at java.io.InputStreamReader.read(InputStreamReader.java:167)
    	at java.io.BufferedReader.fill(BufferedReader.java:136)
    	at java.io.BufferedReader.readLine(BufferedReader.java:299)
    	at java.io.BufferedReader.readLine(BufferedReader.java:362)
    	at com.openexchange.jsieve.SieveHandler.getServerWelcome(SieveHandler.java:509)
    	at com.openexchange.jsieve.SieveHandler.initializeConnection(SieveHandler.java:255)
    	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionConfig(MailfilterAction.java:160)
    	... 16 more
    mailserver:
    Code:
    mnu@xyz1:~$ telnet imap.xyz.at 143
    Trying xxx.xxx.xxx.xxx...
    Connected to imap.xyz.at.
    Escape character is '^]'.
    * OK [CAPABILITY IMAP4 IMAP4rev1 LITERAL+ ID MUPDATE=mupdate://mu.xyz.at/ STARTTLS AUTH=PLAIN SASL-IR ACL RIGHTS=kxte QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY SORT SORT=MODSEQ THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE CATENATE CONDSTORE SCAN IDLE LISTEXT LIST-SUBSCRIBED X-NETSCAPE URLAUTH] ju.xyz.at Cyrus IMAP Murder v2.3.14-xyz-2.1 server ready

  • #2
    Hi,

    the stacktrace contains information that there is a problem with mail filtering, please check if the configuration for the mailfilter plugin matches your installation. You may only remove the bundle if you IMAP server does not support SIEVE at all which seems not to be the case here.

    Greetings

    Comment


    • #3
      partially solved

      thanks. i figured out that our cisco-firewall somehow claims port 2000 for herself. there is a connection established, but some of the tcp-packets were filtered and thrown away. now as this problem ist fixed, there is another one:

      i do not get anny error messages at first, but when i try to save a filter-setting i receive the folowing message:

      27.08.2009 18:36-->Fehlermeldung: null (MAIL_FILTER-0001, -1771305834-1498)

      the logfiles talk about:

      Code:
      	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:417)
      	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:269)
      	at java.util.concurrent.FutureTask.run(FutureTask.java:123)
      	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
      	at java.lang.Thread.run(Thread.java:595)
      Caused by: java.lang.NullPointerException
      	at com.openexchange.jsieve.SieveHandler.getActiveScript(SieveHandler.java:442)
      	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionNew(MailfilterAction.java:316)
      	... 16 more
      anny idea what this "Caused by: java.lang.NullPointerException" might tell me?


      great thanks,
      best regards,
      mnu

      Comment


      • #4
        Hi, this could be a bug, can you please post the complete stacktrace? Thanks!

        Comment


        • #5
          do you mean the logs when you say "stacktrace"?

          Code:
          30.08.2009 15:19:38 com.openexchange.authentication.imap.impl.IMAPAuthentication handleLoginInfo
          INFO: Imap authentication for user xxx successful on host imap.xyz.at:143
          30.08.2009 15:19:38 com.openexchange.sessiond.impl.SessionHandler addSession
          INFO: Session created. ID: 27964d85dbf4436ab10a61c4d03ea6ae, Context: 1, User: 3
          30.08.2009 15:20:04 com.openexchange.mailfilter.ajax.AJAXServlet doGet
          SCHWERWIEGEND: MAIL_FILTER-0001 Category=8 Message=null exceptionID=-647364359-117
          MAIL_FILTER-0001 Category=8 Message=null exceptionID=-647364359-117
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionList(MailfilterAction.java:292)
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionList(MailfilterAction.java:97)
          	at com.openexchange.mailfilter.ajax.actions.AbstractAction.action(AbstractAction.java:97)
          	at com.openexchange.mailfilter.ajax.AJAXServlet.doGet(AJAXServlet.java:191)
          	at javax.servlet.http.HttpServlet.service(HttpServlet.java:596)
          	at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
          	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.doServletService(AJPv13RequestHandlerImpl.java:429)
          	at com.openexchange.ajp13.AJPv13Request.response(AJPv13Request.java:128)
          	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.createResponse(AJPv13RequestHandlerImpl.java:282)
          	at com.openexchange.ajp13.najp.AJPv13ConnectionImpl.createResponse(AJPv13ConnectionImpl.java:189)
          	at com.openexchange.ajp13.najp.AJPv13Task.run(AJPv13Task.java:258)
          	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:417)
          	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:269)
          	at java.util.concurrent.FutureTask.run(FutureTask.java:123)
          	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
          	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
          	at java.lang.Thread.run(Thread.java:595)
          Caused by: java.lang.NullPointerException
          	at com.openexchange.jsieve.SieveHandler.getActiveScript(SieveHandler.java:442)
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionList(MailfilterAction.java:262)
          	... 16 more
          30.08.2009 15:20:29 com.openexchange.mailfilter.ajax.AJAXServlet doPut
          SCHWERWIEGEND: MAIL_FILTER-0001 Category=8 Message=null exceptionID=-647364359-118
          MAIL_FILTER-0001 Category=8 Message=null exceptionID=-647364359-118
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionNew(MailfilterAction.java:367)
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionNew(MailfilterAction.java:97)
          	at com.openexchange.mailfilter.ajax.actions.AbstractAction.action(AbstractAction.java:82)
          	at com.openexchange.mailfilter.ajax.AJAXServlet.doPut(AJAXServlet.java:248)
          	at javax.servlet.http.HttpServlet.service(HttpServlet.java:619)
          	at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
          	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.doServletService(AJPv13RequestHandlerImpl.java:429)
          	at com.openexchange.ajp13.AJPv13Request.response(AJPv13Request.java:128)
          	at com.openexchange.ajp13.najp.AJPv13RequestHandlerImpl.createResponse(AJPv13RequestHandlerImpl.java:282)
          	at com.openexchange.ajp13.najp.AJPv13ConnectionImpl.createResponse(AJPv13ConnectionImpl.java:189)
          	at com.openexchange.ajp13.najp.AJPv13Task.run(AJPv13Task.java:258)
          	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:417)
          	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:269)
          	at java.util.concurrent.FutureTask.run(FutureTask.java:123)
          	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
          	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
          	at java.lang.Thread.run(Thread.java:595)
          Caused by: java.lang.NullPointerException
          	at com.openexchange.jsieve.SieveHandler.getActiveScript(SieveHandler.java:442)
          	at com.openexchange.mailfilter.ajax.actions.MailfilterAction.actionNew(MailfilterAction.java:316)
          	... 16 more
          oxhost:/var/log/open-xchange#
          (in this case i loged on, klicked on "settings" and "filter" after that i tried to save a new filter).

          great thanks and best regards,
          mnu

          Comment


          • #6
            Hi, thanks for the log.

            by "stacktrace" i mean the exception message. The log file contains various stacktraces and normal log output. Gonna check whats on here. I've no idea whats going on here, but i forwarded it to some colleagues. If you don't get a reply at the beginning of next week, please post this one at Bugzilla.

            Greetings
            Last edited by Martin Heiland; 08-30-2009, 04:46 PM.

            Comment


            • #7
              The NPE occurs because the server didn't answer to the listscripts command. According to the managesieve protocol used, the server has to answer with a list of scripts and finally OK or with NO and a reason. But in this case no answer is given.

              Are you sure that the cisco firewall doesn't filter packages on this port anymore? At the moment this would be the only assumption. Because we've seen no cyrus implementation that doesn't answer correct until now.

              If it's possible for you, you can also provide a tcpdump of the communication (be aware that passwords will be contained so change in advance).

              Or you can check the communcation via telnet, it should look like the following:

              Code:
              telnet <sieveserver> 2000
              Trying 127.0.0.1...
              Connected to localhost.
              Escape character is '^]'.
              "IMPLEMENTATION" "Cyrus timsieved v2.2.12"
              "SASL" "LOGIN PLAIN"
              "SIEVE" "fileinto reject envelope vacation imapflags notify subaddress relational comparator-i;ascii-numeric regex"
              OK
              AUTHENTICATE "PLAIN" "<base64 auth string>"
              OK
              listscripts
              "Open-Xchange" ACTIVE
              OK
              With base64 auth string the String
              Code:
              username\0username\0password
              base 64 encoded. This can be archived with:

              Code:
              perl -MMIME::Base64 -e 'print encode_base64("username\0username\0password")."\n";'

              Comment


              • #8
                thank you,

                after my repairs last time telnet returns the follwing greetings:

                Code:
                oxserv:/home/me# telnet imap.xyz.at 2000
                Trying 121.121.121.120...
                Connected to imap.xyz.at.
                Escape character is '^]'.
                "IMPLEMENTATION" "Cyrus timsieved (Murder) v2.3.14-xyz-2.1"
                "SASL" "PLAIN"
                "SIEVE" "comparator-i;ascii-numeric fileinto reject vacation imapflags notify envelope relational regex subaddress copy"
                "STARTTLS"
                OK
                seems ok. but when i try to authenticate the connection is closed. hm?
                i will try to come up with a proper tcpdump.

                best regards,
                mnu

                Comment


                • #9
                  does OX support sieve REFERRAL's?

                  hello again,

                  it seems that this problem is related to our cyrus murder cluster - as the different imap-useraccounts are located on different backends. imap is redirected from the frontend via proxy, but sieve just returns a REFERRAL <sieveurl> (url of the dedicated backend where the users data is stored) statement and quits.

                  see: http://tools.ietf.org/html/draft-iet...managesieve-09
                  Code:
                  REFERRAL
                  
                     This response code may be returned with a BYE result from any
                     command, and includes a mandatory parameter that indicates what
                     server to access to manage this user's sieve scripts.  The server
                     will be specified by a Sieve URL (see Section 3).  The scriptname
                     portion of the URL MUST NOT be specified.  The client should
                     authenticate to the specified server and use it for all further
                     commands in the current session.
                  the tcpdump shows that ox sucessuflly authenticates sieve on the frontend but after it sets of the "LIST RIPTS" command it receives the REFERRAL:
                  Code:
                  10	0.022999	imap_server.ip ox_server.ip TCP	2000 > 59636 [PSH, ACK] Seq=223 Ack=80 Win=5792 Len=60 TSV=2056311454 TSER=601937797
                  data: ...BYE (REFERRAL "sieve://back1.xyz.at") "Try Remote." ...
                  
                  12	0.023216	ox_server.ip imap_server.ip TCP	59636 > 2000 [PSH, ACK] Seq=80 Ack=284 Win=6912  Len=8 TSV=601937797 TSER=2056311454
                  data: ... LOGOUT
                  featurerequest?

                  thanks,
                  best regards,
                  mnu

                  Comment

                  Working...
                  X