Unreliable login - EWS end point not available

Help
Alex
2014-06-03
2014-07-21
  • Alex
    Alex
    2014-06-03

    I am running into an issue with davmail connecting to my server. I once again suspect that it is the fault of the server but that perhaps Davmail isn't handling things as gracefully as it should. Does anyone know how to resolve intermittent login issues with Davmail? Here is the log of a failed, and then successful login attempt:

    369 DEBUG [davmail.pop.PopServer] davmail - Connection from /209.85.223.134 on port 1110
    2014-06-03 10:58:04,384 DEBUG [PopConnection-56188] davmail.exchange.ExchangeSession - Test configuration status: 401
    2014-06-03 10:58:04,400 DEBUG [PopConnection-56188] davmail - > +OK DavMail 4.4.1-2225 POP ready at Tue Jun 03 10:58:04 EDT 2014
    2014-06-03 10:58:04,743 DEBUG [PopConnection-56188] davmail - < USER username
    2014-06-03 10:58:04,743 DEBUG [PopConnection-56188] davmail - > +OK USER : username
    2014-06-03 10:58:04,806 DEBUG [PopConnection-56188] davmail - < PASS *
    2014-06-03 10:58:04,806 DEBUG [PopConnection-56188] davmail - executeFollowRedirects(https://outlook.bigheartlesscompany.org/ews/exchange.asmx)
    2014-06-03 10:58:04,852 DEBUG [PopConnection-56188] davmail - executeFollowRedirects: /ews/Services.wsdl redirectCount:1
    2014-06-03 10:58:05,445 ERROR [PopConnection-56188] davmail.exchange.ExchangeSession - Folder Trash not found
    davmail.exception.HttpNotFoundException: Folder Trash not found
    at davmail.exchange.ews.EwsExchangeSession.internalGetFolder(EwsExchangeSession.java:1135)
    at davmail.exchange.ews.EwsExchangeSession.buildSessionInfo(EwsExchangeSession.java:302)
    at davmail.exchange.ExchangeSession.<init>(ExchangeSession.java:235)
    at davmail.exchange.ews.EwsExchangeSession.<init>(EwsExchangeSession.java:141)
    at davmail.exchange.ExchangeSessionFactory.getInstance(ExchangeSessionFactory.java:143)
    at davmail.exchange.ExchangeSessionFactory.getInstance(ExchangeSessionFactory.java:90)
    at davmail.pop.PopConnection.run(PopConnection.java:140)
    2014-06-03 10:58:05,445 ERROR [PopConnection-56188] davmail.exchange.ExchangeSession - EWS end point not available
    2014-06-03 10:58:05,445 ERROR [PopConnection-56188] davmail - EWS end point not available
    davmail.exception.DavMailAuthenticationException: EWS end point not available
    at davmail.exchange.ews.EwsExchangeSession.buildSessionInfo(EwsExchangeSession.java:307)
    at davmail.exchange.ExchangeSession.<init>(ExchangeSession.java:235)
    at davmail.exchange.ews.EwsExchangeSession.<init>(EwsExchangeSession.java:141)
    at davmail.exchange.ExchangeSessionFactory.getInstance(ExchangeSessionFactory.java:143)
    at davmail.exchange.ExchangeSessionFactory.getInstance(ExchangeSessionFactory.java:90)
    at davmail.pop.PopConnection.run(PopConnection.java:140)
    2014-06-03 10:58:05,445 DEBUG [PopConnection-56188] davmail - > -ERR EWS end point not available
    2014-06-03 10:59:12,229 DEBUG [davmail.pop.PopServer] davmail - Connection from /209.85.213.158 on port 1110
    2014-06-03 10:59:12,463 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Test configuration status: 401
    2014-06-03 10:59:12,463 DEBUG [PopConnection-41078] davmail - > +OK DavMail 4.4.1-2225 POP ready at Tue Jun 03 10:59:12 EDT 2014
    2014-06-03 10:59:12,837 DEBUG [PopConnection-41078] davmail - < USER username
    2014-06-03 10:59:12,837 DEBUG [PopConnection-41078] davmail - > +OK USER : username
    2014-06-03 10:59:12,884 DEBUG [PopConnection-41078] davmail - < PASS
    *
    2014-06-03 10:59:12,884 DEBUG [PopConnection-41078] davmail - executeFollowRedirects(https://outlook.bigheartlesscompany.org/ews/exchange.asmx)
    2014-06-03 10:59:13,118 DEBUG [PopConnection-41078] davmail - executeFollowRedirects: /ews/Services.wsdl redirectCount:1
    2014-06-03 10:59:13,898 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Current user email is USER@bigheartlesscompany.ORG, alias is username on Exchange2010_SP1
    2014-06-03 10:59:13,914 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Session davmail.exchange.ews.EwsExchangeSession@71fcc032 created
    2014-06-03 10:59:13,914 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Created new session: davmail.exchange.ews.EwsExchangeSession@71fcc032
    2014-06-03 10:59:13,914 DEBUG [PopConnection-41078] davmail - > +OK PASS
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - < CAPA
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - > +OK Capability list follows
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - > TOP
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - > USER
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - > UIDL
    2014-06-03 10:59:13,960 DEBUG [PopConnection-41078] davmail - > .
    2014-06-03 10:59:14,132 DEBUG [PopConnection-41078] davmail - < LIST
    2014-06-03 10:59:14,475 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Search items current count: 100 fetchCount: 100 highest uid: 20317 lowest uid: 19925
    2014-06-03 10:59:14,584 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Search items current count: 200 fetchCount: 100 highest uid: 20317 lowest uid: 19517
    2014-06-03 10:59:14,662 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Search items current count: 300 fetchCount: 100 highest uid: 20317 lowest uid: 19094
    2014-06-03 10:59:14,740 DEBUG [PopConnection-41078] davmail.exchange.ExchangeSession - Search items current count: 400 fetchCount: 100 highest uid: 20317 lowest uid: 18597

    The first time, davmail can't find the trash folder, then the next time all is well. I'm not sure if the server is just too slow, or if it is configured incorrectly, but it is very unreliable to login this way, which is causing issues for Google's POP mail fetcher.

    Thanks,
    Alex

     
  • Alex
    Alex
    2014-06-11

    Hi, just as a quick update, I can confirm this is still happening with v4.5.0-2292 after upgrading.

    Thanks,
    Alex

     
  • ... probably the same with 4.5.1, could you please provide an updated log file ?