NoPaste

2021_04_12_Dovecot.log

von sharbich
SNIPPET_DESC:
2021_04_12_Dovecot.log
SNIPPET_CREATION_TIME:
12.04.2021 09:43:06
SNIPPET_PRUNE_TIME:
12.05.2021 09:43:06

SNIPPET_TEXT:
  1. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=100M
  2. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/martina.nitschke
  3. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  4. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=104857600 messages=0
  5. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Quota grace: root=User quota bytes=10485760 (10%)
  6. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/martina.nitschke/mail
  7. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/martina.nitschke/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/martina.nitschke/mail, alt=
  8. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  9. 2021-04-12 08:49:03 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Mailbox Sent: Mailbox opened because: SELECT
  10. 2021-04-12 09:23:16 imap(martina.nitschke)<18076><CpIt48C/HKnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: UID move
  11. 2021-04-12 09:23:16 imap(martina.nitschke)<18076><CpIt48C/HKnAqB5D>: Debug: imapsieve: mailbox Trash: MOVE event
  12. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: UID move
  13. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: imapsieve: mailbox Trash: MOVE event
  14. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: sieve: Pigeonhole version 0.5.4 () initializing
  15. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: sieve: include: sieve_global is not set; it is currently not possible to include `:global' scripts.
  16. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: sieve: Sieve imapsieve plugin for Pigeonhole version 0.5.4 () loaded
  17. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: sieve: Sieve Extprograms plugin for Pigeonhole version 0.5.4 () loaded
  18. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: imapsieve: Static mailbox rule [1]: mailbox=`Spam' from=`*' causes=(COPY) => before=`file:/vmail/sieve/global/learn-spam.sieve' after=(none)
  19. 2021-04-12 09:23:21 imap(martina.nitschke)<18532><pmnD6MC/KqnAqB5D>: Debug: imapsieve: Static mailbox rule [2]: mailbox=`*' from=`Spam' causes=(COPY) => before=`file:/var/vmail/sieve/global/learn-ham.sieve' after=(none)
  20. 2021-04-12 09:23:22 auth: Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
  21. 2021-04-12 09:23:22 auth: Debug: Module loaded: /usr/lib/dovecot/modules/auth/lib20_auth_var_expand_crypt.so
  22. 2021-04-12 09:23:22 auth: Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
  23. 2021-04-12 09:23:22 auth: Debug: Module loaded: /usr/lib/dovecot/modules/auth/libauthdb_ldap.so
  24. 2021-04-12 09:23:22 auth: Debug: Read auth token secret from /var/run/dovecot/auth-token-secret.dat
  25. 2021-04-12 09:23:22 auth: Debug: auth client connected (pid=28619)
  26. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  27. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  28. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  29. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  30. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  31. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  32. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  33. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  34. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  35. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  36. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  37. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  38. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  39. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  40. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  41. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  42. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  43. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  44. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  45. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  46. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  47. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  48. 2021-04-12 09:23:22 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  49. 2021-04-12 09:23:22 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=+CSEY8G/QqnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43330     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  50. 2021-04-12 09:23:22 auth: Debug: client passdb out: CONT        1      
  51. 2021-04-12 09:23:22 auth: Debug: client in: CONT        1       AG1hcnRpbmEubml0c2Noa2VAaGFybmV0LmRlAE1hcnRpbmFOaXRzY2hrZTEy (previous base64 data may contain sensitive data)
  52. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<+CSEY8G/QqnAqB5D>): cache miss
  53. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<+CSEY8G/QqnAqB5D>): pass search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=martina.nitschke)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=uid,userPassword
  54. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<+CSEY8G/QqnAqB5D>): result: uid=martina.nitschke userPassword={SSHA}AsEoPatCkyeVypOLfUqJIxW2B4s5bzJ1; uid,userPassword unused
  55. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<+CSEY8G/QqnAqB5D>): username changed martina.nitschke@example.com -> martina.nitschke
  56. 2021-04-12 09:23:22 auth: Debug: client passdb out: OK  1       user=martina.nitschke           original_user=martina.nitschke@example.com
  57. 2021-04-12 09:23:22 auth: Debug: master in: REQUEST     3118727169      28619   1       e60a871f8226e990e6800a0f93998276        session_pid=28623       request_auth_token
  58. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke,192.168.30.67,<+CSEY8G/QqnAqB5D>): userdb cache miss
  59. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke,192.168.30.67,<+CSEY8G/QqnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=martina.nitschke)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  60. 2021-04-12 09:23:22 auth: Debug: ldap(martina.nitschke,192.168.30.67,<+CSEY8G/QqnAqB5D>): result: uid=martina.nitschke mailQuota=100M; mailQuota,uid unused
  61. 2021-04-12 09:23:22 auth: Debug: master userdb out: USER        3118727169      martina.nitschke        quota_rule=*:bytes=100M home=/vmail/mailboxes/martina.nitschke  mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail    auth_token=2e2eaecd9fbc6c24e798aa263cd7dc66102ee4cd     auth_user=martina.nitschke@example.com
  62. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  63. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  64. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  65. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  66. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail
  67. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=100M
  68. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/martina.nitschke
  69. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  70. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=104857600 messages=0
  71. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Quota grace: root=User quota bytes=10485760 (10%)
  72. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/martina.nitschke/mail
  73. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/martina.nitschke/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/martina.nitschke/mail, alt=
  74. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  75. 2021-04-12 09:23:22 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: SELECT
  76. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: imapsieve: mailbox Trash: FLAG event (changed flags: \Deleted)
  77. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: imapsieve: mailbox Trash: FLAG event (changed flags: \Deleted)
  78. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: sieve: Pigeonhole version 0.5.4 () initializing
  79. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: sieve: include: sieve_global is not set; it is currently not possible to include `:global' scripts.
  80. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: sieve: Sieve imapsieve plugin for Pigeonhole version 0.5.4 () loaded
  81. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: sieve: Sieve Extprograms plugin for Pigeonhole version 0.5.4 () loaded
  82. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: imapsieve: Static mailbox rule [1]: mailbox=`Spam' from=`*' causes=(COPY) => before=`file:/vmail/sieve/global/learn-spam.sieve' after=(none)
  83. 2021-04-12 09:23:27 imap(martina.nitschke)<28623><+CSEY8G/QqnAqB5D>: Debug: imapsieve: Static mailbox rule [2]: mailbox=`*' from=`Spam' causes=(COPY) => before=`file:/var/vmail/sieve/global/learn-ham.sieve' after=(none)
  84. 2021-04-12 09:23:29 auth: Debug: auth client connected (pid=28659)
  85. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  86. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  87. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  88. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  89. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  90. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  91. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  92. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  93. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  94. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  95. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  96. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  97. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  98. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  99. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  100. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  101. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  102. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  103. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  104. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  105. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  106. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  107. 2021-04-12 09:23:29 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  108. 2021-04-12 09:23:29 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=PwfpY8G/RKnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43332     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  109. 2021-04-12 09:23:29 auth: Debug: client passdb out: CONT        1      
  110. 2021-04-12 09:23:29 auth: Debug: client in: CONT        1       AHN0ZWZhbi5oYXJiaWNoQGhhcm5ldC5kZQBTdGVmYW5IYXJiaWNoMTI= (previous base64 data may contain sensitive data)
  111. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<PwfpY8G/RKnAqB5D>): cache miss
  112. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<PwfpY8G/RKnAqB5D>): pass search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=uid,userPassword
  113. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<PwfpY8G/RKnAqB5D>): result: uid=stefan.harbich userPassword={SSHA}rLozj0qwg5FfBUfCh9eeJQqq9vLtmYiJ; uid,userPassword unused
  114. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<PwfpY8G/RKnAqB5D>): username changed stefan.harbich@example.com -> stefan.harbich
  115. 2021-04-12 09:23:29 auth: Debug: client passdb out: OK  1       user=stefan.harbich             original_user=stefan.harbich@example.com
  116. 2021-04-12 09:23:29 auth: Debug: master in: REQUEST     3068264449      28659   1       6b67f34b1a264507760f2a1e677e5791        session_pid=28660       request_auth_token
  117. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich,192.168.30.67,<PwfpY8G/RKnAqB5D>): userdb cache miss
  118. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich,192.168.30.67,<PwfpY8G/RKnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  119. 2021-04-12 09:23:29 auth: Debug: ldap(stefan.harbich,192.168.30.67,<PwfpY8G/RKnAqB5D>): result: uid=stefan.harbich mailQuota=2G; mailQuota,uid unused
  120. 2021-04-12 09:23:29 auth: Debug: master userdb out: USER        3068264449      stefan.harbich  quota_rule=*:bytes=2G   home=/vmail/mailboxes/stefan.harbich    mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail      auth_token=eba4d414c51925e8d30b50c57af7cae04eeeec7c     auth_user=stefan.harbich@example.com
  121. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  122. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  123. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  124. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  125. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail
  126. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=2G
  127. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/stefan.harbich
  128. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  129. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=2147483648 messages=0
  130. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Quota grace: root=User quota bytes=214748364 (10%)
  131. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/stefan.harbich/mail
  132. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/stefan.harbich/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/stefan.harbich/mail, alt=
  133. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  134. 2021-04-12 09:23:29 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: SELECT
  135. 2021-04-12 09:23:34 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: UID move
  136. 2021-04-12 09:23:34 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: imapsieve: mailbox Trash: MOVE event
  137. 2021-04-12 09:23:34 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: imapsieve: mailbox Trash: MOVE event
  138. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: sieve: Pigeonhole version 0.5.4 () initializing
  139. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: sieve: include: sieve_global is not set; it is currently not possible to include `:global' scripts.
  140. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: sieve: Sieve imapsieve plugin for Pigeonhole version 0.5.4 () loaded
  141. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: sieve: Sieve Extprograms plugin for Pigeonhole version 0.5.4 () loaded
  142. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: imapsieve: Static mailbox rule [1]: mailbox=`Spam' from=`*' causes=(COPY) => before=`file:/vmail/sieve/global/learn-spam.sieve' after=(none)
  143. 2021-04-12 09:23:35 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: imapsieve: Static mailbox rule [2]: mailbox=`*' from=`Spam' causes=(COPY) => before=`file:/var/vmail/sieve/global/learn-ham.sieve' after=(none)
  144. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: imapsieve: mailbox Trash: FLAG event (changed flags: \Deleted)
  145. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: imapsieve: mailbox Trash: FLAG event (changed flags: \Deleted)
  146. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: sieve: Pigeonhole version 0.5.4 () initializing
  147. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: sieve: include: sieve_global is not set; it is currently not possible to include `:global' scripts.
  148. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: sieve: Sieve imapsieve plugin for Pigeonhole version 0.5.4 () loaded
  149. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: sieve: Sieve Extprograms plugin for Pigeonhole version 0.5.4 () loaded
  150. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: imapsieve: Static mailbox rule [1]: mailbox=`Spam' from=`*' causes=(COPY) => before=`file:/vmail/sieve/global/learn-spam.sieve' after=(none)
  151. 2021-04-12 09:23:40 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: imapsieve: Static mailbox rule [2]: mailbox=`*' from=`Spam' causes=(COPY) => before=`file:/var/vmail/sieve/global/learn-ham.sieve' after=(none)
  152. 2021-04-12 09:23:45 imap(stefan.harbich)<18075><bEAt48C/GqnAqB5D>: Debug: Mailbox Trash: Mailbox opened because: UID move
  153. 2021-04-12 09:23:45 imap(stefan.harbich)<18075><bEAt48C/GqnAqB5D>: Debug: imapsieve: mailbox Trash: MOVE event
  154. 2021-04-12 09:23:50 imap(stefan.harbich)<28660><PwfpY8G/RKnAqB5D>: Debug: imapsieve: mailbox Trash: FLAG event (changed flags: \Deleted)
  155. 2021-04-12 09:23:56 auth: Debug: auth client connected (pid=28788)
  156. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  157. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  158. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  159. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  160. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  161. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  162. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  163. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  164. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  165. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  166. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  167. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  168. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  169. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  170. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  171. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  172. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  173. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  174. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  175. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  176. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  177. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  178. 2021-04-12 09:23:56 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  179. 2021-04-12 09:23:56 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=RaCBZcG/RqnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43334     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  180. 2021-04-12 09:23:56 auth: Debug: client passdb out: CONT        1      
  181. 2021-04-12 09:23:56 auth: Debug: client in: CONT        1       AG1hcnRpbmEubml0c2Noa2VAaGFybmV0LmRlAE1hcnRpbmFOaXRzY2hrZTEy (previous base64 data may contain sensitive data)
  182. 2021-04-12 09:23:56 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<RaCBZcG/RqnAqB5D>): cache hit: {SSHA}AsEoPatCkyeVypOLfUqJIxW2B4s5bzJ1user=martina.nitschke
  183. 2021-04-12 09:23:56 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<RaCBZcG/RqnAqB5D>): username changed martina.nitschke@example.com -> martina.nitschke
  184. 2021-04-12 09:23:56 auth: Debug: client passdb out: OK  1       user=martina.nitschke           original_user=martina.nitschke@example.com
  185. 2021-04-12 09:23:56 auth: Debug: master in: REQUEST     926679041       28788   1       3c86f8507214ec3bc471c8c389790870        session_pid=28791       request_auth_token
  186. 2021-04-12 09:23:56 auth: Debug: ldap(martina.nitschke,192.168.30.67,<RaCBZcG/RqnAqB5D>): userdb cache miss
  187. 2021-04-12 09:23:56 auth: Debug: ldap(martina.nitschke,192.168.30.67,<RaCBZcG/RqnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=martina.nitschke)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  188. 2021-04-12 09:23:56 auth: Debug: ldap(martina.nitschke,192.168.30.67,<RaCBZcG/RqnAqB5D>): result: uid=martina.nitschke mailQuota=100M; mailQuota,uid unused
  189. 2021-04-12 09:23:56 auth: Debug: master userdb out: USER        926679041       martina.nitschke        quota_rule=*:bytes=100M home=/vmail/mailboxes/martina.nitschke  mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail    auth_token=7573b44169f8572f07d472c4adb594faef29c1b9     auth_user=martina.nitschke@example.com
  190. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  191. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  192. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  193. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  194. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail
  195. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=100M
  196. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/martina.nitschke
  197. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  198. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=104857600 messages=0
  199. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Quota grace: root=User quota bytes=10485760 (10%)
  200. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/martina.nitschke/mail
  201. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/martina.nitschke/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/martina.nitschke/mail, alt=
  202. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  203. 2021-04-12 09:23:56 imap(martina.nitschke)<28791><RaCBZcG/RqnAqB5D>: Debug: Mailbox Spam: Mailbox opened because: SELECT
  204. 2021-04-12 09:23:57 auth: Debug: auth client connected (pid=28796)
  205. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  206. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  207. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  208. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  209. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  210. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  211. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  212. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  213. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  214. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  215. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  216. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  217. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  218. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  219. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  220. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  221. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  222. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  223. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  224. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  225. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  226. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  227. 2021-04-12 09:23:57 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  228. 2021-04-12 09:23:57 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=aMaRZcG/SKnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43336     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  229. 2021-04-12 09:23:57 auth: Debug: client passdb out: CONT        1      
  230. 2021-04-12 09:23:57 auth: Debug: client in: CONT        1       AG1hcnRpbmEubml0c2Noa2VAaGFybmV0LmRlAE1hcnRpbmFOaXRzY2hrZTEy (previous base64 data may contain sensitive data)
  231. 2021-04-12 09:23:57 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<aMaRZcG/SKnAqB5D>): cache hit: {SSHA}AsEoPatCkyeVypOLfUqJIxW2B4s5bzJ1user=martina.nitschke
  232. 2021-04-12 09:23:57 auth: Debug: ldap(martina.nitschke@example.com,192.168.30.67,<aMaRZcG/SKnAqB5D>): username changed martina.nitschke@example.com -> martina.nitschke
  233. 2021-04-12 09:23:57 auth: Debug: client passdb out: OK  1       user=martina.nitschke           original_user=martina.nitschke@example.com
  234. 2021-04-12 09:23:57 auth: Debug: master in: REQUEST     3760193537      28796   1       1d43dbe12955af7a89645d419c101714        session_pid=28797       request_auth_token
  235. 2021-04-12 09:23:57 auth: Debug: ldap(martina.nitschke,192.168.30.67,<aMaRZcG/SKnAqB5D>): userdb cache miss
  236. 2021-04-12 09:23:57 auth: Debug: ldap(martina.nitschke,192.168.30.67,<aMaRZcG/SKnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=martina.nitschke)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  237. 2021-04-12 09:23:57 auth: Debug: ldap(martina.nitschke,192.168.30.67,<aMaRZcG/SKnAqB5D>): result: uid=martina.nitschke mailQuota=100M; mailQuota,uid unused
  238. 2021-04-12 09:23:57 auth: Debug: master userdb out: USER        3760193537      martina.nitschke        quota_rule=*:bytes=100M home=/vmail/mailboxes/martina.nitschke  mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail    auth_token=7914612f03c5233c12e37efdd8b46127405753da     auth_user=martina.nitschke@example.com
  239. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  240. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  241. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  242. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  243. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/martina.nitschke/mail
  244. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=100M
  245. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/martina.nitschke
  246. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  247. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=104857600 messages=0
  248. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Quota grace: root=User quota bytes=10485760 (10%)
  249. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/martina.nitschke/mail
  250. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/martina.nitschke/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/martina.nitschke/mail, alt=
  251. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  252. 2021-04-12 09:23:57 imap(martina.nitschke)<28797><aMaRZcG/SKnAqB5D>: Debug: Mailbox Drafts: Mailbox opened because: SELECT
  253. 2021-04-12 09:23:58 auth: Debug: auth client connected (pid=28800)
  254. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  255. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  256. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  257. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  258. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  259. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  260. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  261. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  262. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  263. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  264. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  265. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  266. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  267. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  268. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  269. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  270. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  271. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  272. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  273. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  274. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  275. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  276. 2021-04-12 09:23:58 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  277. 2021-04-12 09:23:58 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=J3+nZcG/SqnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43338     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  278. 2021-04-12 09:23:58 auth: Debug: client passdb out: CONT        1      
  279. 2021-04-12 09:23:58 auth: Debug: client in: CONT        1       AHN0ZWZhbi5oYXJiaWNoQGhhcm5ldC5kZQBTdGVmYW5IYXJiaWNoMTI= (previous base64 data may contain sensitive data)
  280. 2021-04-12 09:23:58 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<J3+nZcG/SqnAqB5D>): cache hit: {SSHA}rLozj0qwg5FfBUfCh9eeJQqq9vLtmYiJ   user=stefan.harbich
  281. 2021-04-12 09:23:58 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<J3+nZcG/SqnAqB5D>): username changed stefan.harbich@example.com -> stefan.harbich
  282. 2021-04-12 09:23:58 auth: Debug: client passdb out: OK  1       user=stefan.harbich             original_user=stefan.harbich@example.com
  283. 2021-04-12 09:23:58 auth: Debug: master in: REQUEST     3761242113      28800   1       a1a7d602463ef28ad372c36ae00aaabe        session_pid=28801       request_auth_token
  284. 2021-04-12 09:23:58 auth: Debug: ldap(stefan.harbich,192.168.30.67,<J3+nZcG/SqnAqB5D>): userdb cache miss
  285. 2021-04-12 09:23:58 auth: Debug: ldap(stefan.harbich,192.168.30.67,<J3+nZcG/SqnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  286. 2021-04-12 09:23:58 auth: Debug: ldap(stefan.harbich,192.168.30.67,<J3+nZcG/SqnAqB5D>): result: uid=stefan.harbich mailQuota=2G; mailQuota,uid unused
  287. 2021-04-12 09:23:58 auth: Debug: master userdb out: USER        3761242113      stefan.harbich  quota_rule=*:bytes=2G   home=/vmail/mailboxes/stefan.harbich    mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail      auth_token=93036b43f21ed85749d342d8c30c6406f6b54471     auth_user=stefan.harbich@example.com
  288. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  289. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  290. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  291. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  292. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail
  293. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=2G
  294. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/stefan.harbich
  295. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  296. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=2147483648 messages=0
  297. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Quota grace: root=User quota bytes=214748364 (10%)
  298. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/stefan.harbich/mail
  299. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/stefan.harbich/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/stefan.harbich/mail, alt=
  300. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  301. 2021-04-12 09:23:58 imap(stefan.harbich)<28801><J3+nZcG/SqnAqB5D>: Debug: Mailbox Spam: Mailbox opened because: SELECT
  302. 2021-04-12 09:23:59 auth: Debug: auth client connected (pid=28804)
  303. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  304. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  305. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  306. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  307. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  308. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  309. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  310. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  311. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  312. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  313. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  314. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  315. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  316. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  317. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  318. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  319. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  320. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  321. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  322. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  323. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  324. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  325. 2021-04-12 09:23:59 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  326. 2021-04-12 09:23:59 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=JLu2ZcG/TKnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43340     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  327. 2021-04-12 09:23:59 auth: Debug: client passdb out: CONT        1      
  328. 2021-04-12 09:23:59 auth: Debug: client in: CONT        1       AHN0ZWZhbi5oYXJiaWNoQGhhcm5ldC5kZQBTdGVmYW5IYXJiaWNoMTI= (previous base64 data may contain sensitive data)
  329. 2021-04-12 09:23:59 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<JLu2ZcG/TKnAqB5D>): cache hit: {SSHA}rLozj0qwg5FfBUfCh9eeJQqq9vLtmYiJ   user=stefan.harbich
  330. 2021-04-12 09:23:59 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<JLu2ZcG/TKnAqB5D>): username changed stefan.harbich@example.com -> stefan.harbich
  331. 2021-04-12 09:23:59 auth: Debug: client passdb out: OK  1       user=stefan.harbich             original_user=stefan.harbich@example.com
  332. 2021-04-12 09:23:59 auth: Debug: master in: REQUEST     4013686785      28804   1       f5ca222e36b91cc68eace545c1b610f5        session_pid=28805       request_auth_token
  333. 2021-04-12 09:23:59 auth: Debug: ldap(stefan.harbich,192.168.30.67,<JLu2ZcG/TKnAqB5D>): userdb cache miss
  334. 2021-04-12 09:23:59 auth: Debug: ldap(stefan.harbich,192.168.30.67,<JLu2ZcG/TKnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  335. 2021-04-12 09:23:59 auth: Debug: ldap(stefan.harbich,192.168.30.67,<JLu2ZcG/TKnAqB5D>): result: uid=stefan.harbich mailQuota=2G; mailQuota,uid unused
  336. 2021-04-12 09:23:59 auth: Debug: master userdb out: USER        4013686785      stefan.harbich  quota_rule=*:bytes=2G   home=/vmail/mailboxes/stefan.harbich    mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail      auth_token=683d167bb052c0ed5341f92c90cbdd35da3e6ad6     auth_user=stefan.harbich@example.com
  337. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  338. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  339. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  340. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  341. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail
  342. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=2G
  343. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/stefan.harbich
  344. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  345. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=2147483648 messages=0
  346. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Quota grace: root=User quota bytes=214748364 (10%)
  347. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/stefan.harbich/mail
  348. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/stefan.harbich/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/stefan.harbich/mail, alt=
  349. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  350. 2021-04-12 09:23:59 imap(stefan.harbich)<28805><JLu2ZcG/TKnAqB5D>: Debug: Mailbox Drafts: Mailbox opened because: SELECT
  351. 2021-04-12 09:25:52 auth: Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
  352. 2021-04-12 09:25:52 auth: Debug: Module loaded: /usr/lib/dovecot/modules/auth/lib20_auth_var_expand_crypt.so
  353. 2021-04-12 09:25:52 auth: Debug: Loading modules from directory: /usr/lib/dovecot/modules/auth
  354. 2021-04-12 09:25:52 auth: Debug: Module loaded: /usr/lib/dovecot/modules/auth/libauthdb_ldap.so
  355. 2021-04-12 09:25:52 auth: Debug: Read auth token secret from /var/run/dovecot/auth-token-secret.dat
  356. 2021-04-12 09:25:52 auth: Debug: auth client connected (pid=0)
  357. 2021-04-12 09:25:52 auth: Debug: client in: AUTH        1       PLAIN   service=smtp    nologin lip=192.168.20.20       rip=192.168.30.67       secured resp=AHN0ZWZhbi5oYXJiaWNoQGhhcm5ldC5kZQBTdGVmYW5IYXJiaWNoMTI= (previous base64 data may contain sensitive data)
  358. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67): cache miss
  359. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67): pass search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=uid,userPassword
  360. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67): result: uid=stefan.harbich userPassword={SSHA}rLozj0qwg5FfBUfCh9eeJQqq9vLtmYiJ; uid,userPassword unused
  361. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67): username changed stefan.harbich@example.com -> stefan.harbich
  362. 2021-04-12 09:25:52 auth: Debug: client passdb out: OK  1       user=stefan.harbich             original_user=stefan.harbich@example.com
  363. 2021-04-12 09:25:52 lmtp(martina.nitschke@example.com)<29365><0HbJHwD2c2C1cgAAFadBhw>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  364. 2021-04-12 09:25:52 lmtp(martina.nitschke@example.com)<29365><0HbJHwD2c2C1cgAAFadBhw>: Debug: Module loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
  365. 2021-04-12 09:25:52 lmtp(martina.nitschke@example.com)<29365><0HbJHwD2c2C1cgAAFadBhw>: Debug: Module loaded: /usr/lib/dovecot/modules/lib20_push_notification_plugin.so
  366. 2021-04-12 09:25:52 lmtp(martina.nitschke@example.com)<29365><0HbJHwD2c2C1cgAAFadBhw>: Debug: Module loaded: /usr/lib/dovecot/modules/lib90_sieve_plugin.so
  367. 2021-04-12 09:25:52 auth: Debug: master in: USER        1       martina.nitschke@example.com    service=lmtp
  368. 2021-04-12 09:25:52 auth: Debug: ldap(martina.nitschke@example.com): userdb cache miss
  369. 2021-04-12 09:25:52 auth: Debug: ldap(martina.nitschke@example.com): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=martina.nitschke@example.com)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  370. 2021-04-12 09:25:52 auth: Debug: ldap(martina.nitschke@example.com): no fields returned by the server
  371. 2021-04-12 09:25:52 auth: Debug: userdb out: NOTFOUND   1
  372. 2021-04-12 09:25:52 lmtp(martina.nitschke@example.com)<29365><0HbJHwD2c2C1cgAAFadBhw>: Debug: auth USER input:
  373. 2021-04-12 09:25:52 auth: Debug: master in: USER        2       stefan.harbich@example.com      service=lmtp
  374. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com): userdb cache miss
  375. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich@example.com)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  376. 2021-04-12 09:25:52 auth: Debug: ldap(stefan.harbich@example.com): no fields returned by the server
  377. 2021-04-12 09:25:52 auth: Debug: userdb out: NOTFOUND   2
  378. 2021-04-12 09:25:52 lmtp(stefan.harbich@example.com)<29365><EJctJgD2c2C1cgAAFadBhw>: Debug: auth USER input:
  379. 2021-04-12 09:25:52 imap(stefan.harbich)<18261><Rhw+5cC/JqnAqB5D>: Debug: imapsieve: mailbox Sent: APPEND event
  380. 2021-04-12 09:25:53 imap-login: Debug: SSL alert: close notify
  381. 2021-04-12 09:25:53 imap-login: Debug: SSL alert: close notify
  382. 2021-04-12 09:26:06 auth: Debug: auth client connected (pid=29438)
  383. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization
  384. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  385. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  386. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization
  387. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization
  388. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello
  389. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello
  390. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec
  391. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions
  392. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate
  393. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify
  394. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished
  395. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  396. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  397. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  398. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  399. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data
  400. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data
  401. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished
  402. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket
  403. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  404. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket
  405. 2021-04-12 09:26:06 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully
  406. 2021-04-12 09:26:06 auth: Debug: client in: AUTH        1       PLAIN   service=imap    secured=tls     session=GlhKbcG/UqnAqB5D        lip=192.168.20.20       rip=192.168.30.67       lport=143       rport=43346     local_name=imap.intern.example.com      ssl_cipher=TLS_AES_128_GCM_SHA256       ssl_cipher_bits=128     ssl_pfs=KxANY   ssl_protocol=TLSv1.3
  407. 2021-04-12 09:26:06 auth: Debug: client passdb out: CONT        1      
  408. 2021-04-12 09:26:06 auth: Debug: client in: CONT        1       AHN0ZWZhbi5oYXJiaWNoQGhhcm5ldC5kZQBTdGVmYW5IYXJiaWNoMTI= (previous base64 data may contain sensitive data)
  409. 2021-04-12 09:26:06 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<GlhKbcG/UqnAqB5D>): cache hit: {SSHA}rLozj0qwg5FfBUfCh9eeJQqq9vLtmYiJ   user=stefan.harbich
  410. 2021-04-12 09:26:06 auth: Debug: ldap(stefan.harbich@example.com,192.168.30.67,<GlhKbcG/UqnAqB5D>): username changed stefan.harbich@example.com -> stefan.harbich
  411. 2021-04-12 09:26:06 auth: Debug: client passdb out: OK  1       user=stefan.harbich             original_user=stefan.harbich@example.com
  412. 2021-04-12 09:26:06 auth: Debug: master in: REQUEST     1065484289      29438   1       1b3ce92037fd22dd95eff66f0f2fb97a        session_pid=29439       request_auth_token
  413. 2021-04-12 09:26:06 auth: Debug: ldap(stefan.harbich,192.168.30.67,<GlhKbcG/UqnAqB5D>): userdb cache miss
  414. 2021-04-12 09:26:06 auth: Debug: ldap(stefan.harbich,192.168.30.67,<GlhKbcG/UqnAqB5D>): user search: base=ou=users,dc=harnet,dc=de scope=subtree filter=(&(uid=stefan.harbich)(objectClass=inetOrgPerson)(mailEnabled=TRUE)) fields=mailQuota,uid,uid
  415. 2021-04-12 09:26:06 auth: Debug: ldap(stefan.harbich,192.168.30.67,<GlhKbcG/UqnAqB5D>): result: uid=stefan.harbich mailQuota=2G; mailQuota,uid unused
  416. 2021-04-12 09:26:06 auth: Debug: master userdb out: USER        1065484289      stefan.harbich  quota_rule=*:bytes=2G   home=/vmail/mailboxes/stefan.harbich    mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail      auth_token=6e9680681785f7b50af615525486d89994e2002c     auth_user=stefan.harbich@example.com
  417. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Loading modules from directory: /usr/lib/dovecot/modules
  418. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
  419. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
  420. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_sieve_plugin.so
  421. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Added userdb setting: mail_location=maildir:/vmail/mailboxes/stefan.harbich/mail
  422. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=2G
  423. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Effective uid=10009, gid=10010, home=/vmail/mailboxes/stefan.harbich
  424. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Quota root: name=User quota backend=maildir args=
  425. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Quota rule: root=User quota mailbox=* bytes=2147483648 messages=0
  426. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Quota grace: root=User quota bytes=214748364 (10%)
  427. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/vmail/mailboxes/stefan.harbich/mail
  428. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: maildir++: root=/vmail/mailboxes/stefan.harbich/mail, index=, indexpvt=, control=, inbox=/vmail/mailboxes/stefan.harbich/mail, alt=
  429. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
  430. 2021-04-12 09:26:06 imap(stefan.harbich)<29439><GlhKbcG/UqnAqB5D>: Debug: Mailbox Sent: Mailbox opened because: SELECT

Quellcode

Hier kannst du den Code kopieren und ihn in deinen bevorzugten Editor einfügen. PASTEBIN_DOWNLOAD_SNIPPET_EXPLAIN