none
Exchange 2010 SP3, POP3: DEL Befehl wird nicht ausgeführt - Mails werden doppelt abgeholt

    Frage

  • Hallo,

    wir haben ein DMS das Mails minütlich per POP3 abholt und leider keine anderen Protokolle wie z.B. IMP unterstützt und auch keine Verwaltung von MessageIDs zur Erkennung von Duplikaten enthält. Es kommt damit immer wieder vor, das Mails in der Software doppelt erscheinen. Zu Diagnosezwecken wurde auf dem Exchange das POP3-Loggin aktiviert. Laut Logfile führt die Software nach dem RETR ein DEL aus was vom Server mit OK bestätigt wird. Bei der nächsten Query werden die zuvor gelöschten Mails aber erneut angeboten.

    Kannt jemand das Problem?

    Hier der Logauszug. Anhand der Mailgröße kann man sehen, dass es sich bei list 1-3 um die selbven Mails handelt.

    # Die drei betroffenen Mails empfangen und gelöscht:
    2017-05-15T08:23:20.425Z,000000000000F392,0,192.168.77.4:995,192.168.77.13:59308,,-2147483648,0,32,OpenSession,,
    2017-05-15T08:23:20.644Z,000000000000F392,1,192.168.77.4:995,192.168.77.13:59308,,0,14,5,user,greyhound,R=ok
    2017-05-15T08:23:20.706Z,000000000000F392,2,192.168.77.4:995,192.168.77.13:59308,greyhound,62,10,34,pass,*****,"R=ok;RpcC=13;RpcL=16;LdapC=2;Msg=""User:adelphi - Rechungseingang:cea27763-f058-4f75-be9c-d7c3e24cdd8d:Main:DC1.intern.adelphi.de"";Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:20.706Z,000000000000F392,3,192.168.77.4:995,192.168.77.13:59308,greyhound,0,4,14,stat,,"R=ok;Rows=3;TotalSize=276908;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:20.706Z,000000000000F392,4,192.168.77.4:995,192.168.77.13:59308,greyhound,0,4,35,uidl,,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:20.722Z,000000000000F392,5,192.168.77.4:995,192.168.77.13:59308,greyhound,15,6,13,list,1,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:20.800Z,000000000000F392,6,192.168.77.4:995,192.168.77.13:59308,greyhound,78,6,126765,retr,1,"R=ok;RpcC=8;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.127Z,000000000000F392,7,192.168.77.4:995,192.168.77.13:59308,greyhound,0,6,5,dele,1,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.127Z,000000000000F392,8,192.168.77.4:995,192.168.77.13:59308,greyhound,0,6,13,list,2,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.392Z,000000000000F392,9,192.168.77.4:995,192.168.77.13:59308,greyhound,249,6,128563,retr,2,"R=ok;RpcC=6;RpcL=31;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.704Z,000000000000F392,10,192.168.77.4:995,192.168.77.13:59308,greyhound,0,6,5,dele,2,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.704Z,000000000000F392,11,192.168.77.4:995,192.168.77.13:59308,greyhound,0,6,13,list,3,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:21.829Z,000000000000F392,12,192.168.77.4:995,192.168.77.13:59308,greyhound,124,6,124159,retr,3,"R=ok;RpcC=5;RpcL=16;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:22.157Z,000000000000F392,13,192.168.77.4:995,192.168.77.13:59308,greyhound,15,6,5,dele,3,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:23:22.188Z,000000000000F392,14,192.168.77.4:995,192.168.77.13:59308,greyhound,0,0,0,CloseSession,,"Budget=""Conn:0,HangingConn:0,AD:$null/$null/0%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""

    # Die nächste Query zeigt die ersten drei Mails wieder an:
    2017-05-15T08:24:22.748Z,000000000000F394,0,192.168.77.4:995,192.168.77.13:59310,,-2147483648,0,32,OpenSession,,
    2017-05-15T08:24:22.966Z,000000000000F394,1,192.168.77.4:995,192.168.77.13:59310,,0,14,5,user,greyhound,R=ok
    2017-05-15T08:24:23.138Z,000000000000F394,2,192.168.77.4:995,192.168.77.13:59310,greyhound,156,10,34,pass,*****,"R=ok;RpcC=13;RpcL=15;LdapC=2;LdapL=16;Msg=""User:adelphi - Rechungseingang:cea27763-f058-4f75-be9c-d7c3e24cdd8d:Main:DC1.intern.adelphi.de"";Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.138Z,000000000000F394,3,192.168.77.4:995,192.168.77.13:59310,greyhound,0,4,14,stat,,"R=ok;Rows=6;TotalSize=489218;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.138Z,000000000000F394,4,192.168.77.4:995,192.168.77.13:59310,greyhound,0,4,62,uidl,,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.138Z,000000000000F394,5,192.168.77.4:995,192.168.77.13:59310,greyhound,0,6,13,list,1,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/0%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.263Z,000000000000F394,6,192.168.77.4:995,192.168.77.13:59310,greyhound,124,6,126765,retr,1,"R=ok;RpcC=8;RpcL=31;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.559Z,000000000000F394,7,192.168.77.4:995,192.168.77.13:59310,greyhound,0,6,5,dele,1,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.575Z,000000000000F394,8,192.168.77.4:995,192.168.77.13:59310,greyhound,15,6,13,list,2,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.606Z,000000000000F394,9,192.168.77.4:995,192.168.77.13:59310,greyhound,31,6,128563,retr,2,"R=ok;RpcC=6;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.918Z,000000000000F394,10,192.168.77.4:995,192.168.77.13:59310,greyhound,0,6,5,dele,2,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:23.934Z,000000000000F394,11,192.168.77.4:995,192.168.77.13:59310,greyhound,0,6,13,list,3,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:24.027Z,000000000000F394,12,192.168.77.4:995,192.168.77.13:59310,greyhound,93,6,124159,retr,3,"R=ok;RpcC=5;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""
    2017-05-15T08:24:24.324Z,000000000000F394,13,192.168.77.4:995,192.168.77.13:59310,greyhound,0,6,5,dele,3,"R=ok;Budget=""Conn:0,HangingConn:0,AD:$null/$null/1%,CAS:$null/$null/1%,AB:$null/$null/0%,RPC:$null/$null/1%,FC:1000/0,Policy:LimitMessagesSent200-3,Norm[Resources:(DC)DC1.intern.adelphi.de(Health:-1%,HistLoad:0),(Mdb)Main(Health:-1%,HistLoad:0),]"""






    Freitag, 19. Mai 2017 12:13

Antworten

  • Hallo,

    zuerst einmal würde ich das Polling Intervall auf 5 Minuten setzen, damit der Server eine Chance hat, das Kommando umzusetzen, bevor die nächste Anfrage kommt.

    Beste Grüße,
    Thomas


    Thomas Stensitzki - MCSM, MCM, MCSE, MCSA, MCITP - Blog: http://justcantgetenough.granikos.eu/

    Freitag, 19. Mai 2017 12:25

Alle Antworten

  • Hallo,

    zuerst einmal würde ich das Polling Intervall auf 5 Minuten setzen, damit der Server eine Chance hat, das Kommando umzusetzen, bevor die nächste Anfrage kommt.

    Beste Grüße,
    Thomas


    Thomas Stensitzki - MCSM, MCM, MCSE, MCSA, MCITP - Blog: http://justcantgetenough.granikos.eu/

    Freitag, 19. Mai 2017 12:25
  • Danke, das habe ich schon befürchtet. Das Intervall ist in dem DMS leider hart codiert. :( Da muss ich wohl mal mit dem Hesteller reden...

    Danke für die schnelle Hilfe!

    Freitag, 19. Mai 2017 13:08
  • Moin,

    wenn Du mit dem Hersteller sprichst, weise ihn bitte auch noch darauf hin, dass Exchange (wie auch jeder andere RFC-konforme POP3-Server) die Mails erst löscht, wenn der Befehl QUIT ausgegeben wird, und nicht bereits bei DELE. Denn bis dahin könnte theoretisch auch ein RSET kommen, das die DELE-Aktionen der aktuellen Sitzung zurück ruft.

    Somit ist das Verhalten laut Deinem Log korrekt, denn da wird die Sitzung anscheinend einfach abgerissen, ohne dass ein QUIT ausgegeben wird.


    Evgenij Smirnov

    I work @ msg services ag, Berlin -> http://www.msg-services.de
    I blog (in German) @ http://it-pro-berlin.de
    my stuff in PSGallery --> https://www.powershellgallery.com/profiles/it-pro-berlin.de/
    Exchange User Group, Berlin -> http://exusg.de
    Windows Server User Group, Berlin -> http://www.winsvr-berlin.de
    Mark Minasi Technical Forum, reloaded -> http://newforum.minasi.com

    Freitag, 19. Mai 2017 17:37