Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: Connect [127.0.0.1:389]
Jul 9 17:51:01 mail roundcube: <pij0jmsk> S: OK
Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: Bind [dn: mail=bbbb@mydomain.com,ou=Users,domainName=mydomain.com,o=domains,dc=mydomain,dc=com]
Jul 9 17:51:01 mail roundcube: <pij0jmsk> S: OK
Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: Search base dn: [domainName=mydomain.com,o=domains,dc=mydomain,dc=com] scope [sub] with filter [(&(&(enabledService=mail)(enabledService=deliver)(enabledService=displayedInGlobalAddressBook)(|(objectClass=mailUser)(objectClass=mailList)(objectClass=mailAlias)))(|(cn=*aaa*)(givenname=*aaa*)(sn=*aaa*)(mail=*aaa*)))]
Jul 9 17:51:01 mail roundcube: <pij0jmsk> Using function ldap_search on scope sub ($ns_function is ldap_search)
Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: (Without VLV) Setting a filter of (&(&(enabledService=mail)(enabledService=deliver)(enabledService=displayedInGlobalAddressBook)(|(objectClass=mailUser)(objectClass=mailList)(objectClass=mailAlias)))(|(cn=*aaa*)(givenname=*aaa*)(sn=*aaa*)(mail=*aaa*)))
Jul 9 17:51:01 mail roundcube: <pij0jmsk> Executing search with return attributes: array (#012 0 => 'cn',#012 1 => 'sn',#012 2 => 'givenname',#012 3 => 'title',#012 4 => 'mail',#012 5 => 'telephonenumber',#012 6 => 'mobile',#012 7 => 'facsimiletelephonenumber',#012 8 => 'street',#012 9 => 'postalcode',#012 10 => 'l',#012 11 => 'departmentnumber',#012 12 => 'description',#012 13 => 'jpegphoto',#012 14 => 'objectClass',#012 15 => 'cn',#012)
Jul 9 17:51:01 mail roundcube: <pij0jmsk> S: 1 record(s) found
Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: Search base dn: [domainName=mydomain.com,o=domains,dc=mydomain,dc=com] scope [] with filter [(&(=*aaa*))]
Jul 9 17:51:01 mail roundcube: <pij0jmsk> Using function ldap_list on scope ($ns_function is ldap_read)
Jul 9 17:51:01 mail roundcube: <pij0jmsk> C: (Without VLV) Setting a filter of (&(=*aaa*))
Jul 9 17:51:01 mail roundcube: <pij0jmsk> Executing search with return attributes: array (#012 0 => 'dn',#012 1 => 'objectClass',#012 2 => NULL,#012 3 => 'mail',#012)
Jul 9 17:51:01 mail roundcube: <pij0jmsk> PHP Error: LDAP: ldap_list failed for dn=domainName=mydomain.com,o=domains,dc=mydomain,dc=com. Bad search filter (POST /mail/?_task=mail&_action=autocomplete)
Jul 9 17:51:01 mail journal: ool www: <pij0jmsk> C: Close
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: Connect [127.0.0.1:389]
Jul 9 17:51:02 mail roundcube: <pij0jmsk> S: OK
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: Bind [dn: mail=bbbb@mydomain.com,ou=Users,domainName=mydomain.com,o=domains,dc=mydomain,dc=com]
Jul 9 17:51:02 mail roundcube: <pij0jmsk> S: OK
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: Search base dn: [domainName=mydomain.com,o=domains,dc=mydomain,dc=com] scope [sub] with filter [(&(&(enabledService=mail)(enabledService=deliver)(enabledService=displayedInGlobalAddressBook)(|(objectClass=mailUser)(objectClass=mailList)(objectClass=mailAlias)))(|(cn=*aaaa*)(givenname=*aaaa*)(sn=*aaaa*)(mail=*aaaa*)))]
Jul 9 17:51:02 mail roundcube: <pij0jmsk> Using function ldap_search on scope sub ($ns_function is ldap_search)
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: (Without VLV) Setting a filter of (&(&(enabledService=mail)(enabledService=deliver)(enabledService=displayedInGlobalAddressBook)(|(objectClass=mailUser)(objectClass=mailList)(objectClass=mailAlias)))(|(cn=*aaaa*)(givenname=*aaaa*)(sn=*aaaa*)(mail=*aaaa*)))
Jul 9 17:51:02 mail roundcube: <pij0jmsk> Executing search with return attributes: array (#012 0 => 'cn',#012 1 => 'sn',#012 2 => 'givenname',#012 3 => 'title',#012 4 => 'mail',#012 5 => 'telephonenumber',#012 6 => 'mobile',#012 7 => 'facsimiletelephonenumber',#012 8 => 'street',#012 9 => 'postalcode',#012 10 => 'l',#012 11 => 'departmentnumber',#012 12 => 'description',#012 13 => 'jpegphoto',#012 14 => 'objectClass',#012 15 => 'cn',#012)
Jul 9 17:51:02 mail roundcube: <pij0jmsk> S: 1 record(s) found
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: Search base dn: [domainName=mydomain.com,o=domains,dc=mydomain,dc=com] scope [] with filter [(&(=*aaaa*))]
Jul 9 17:51:02 mail roundcube: <pij0jmsk> Using function ldap_list on scope ($ns_function is ldap_read)
Jul 9 17:51:02 mail roundcube: <pij0jmsk> C: (Without VLV) Setting a filter of (&(=*aaaa*))
Jul 9 17:51:02 mail roundcube: <pij0jmsk> Executing search with return attributes: array (#012 0 => 'dn',#012 1 => 'objectClass',#012 2 => NULL,#012 3 => 'mail',#012)
Jul 9 17:51:02 mail roundcube: <pij0jmsk> PHP Error: LDAP: ldap_list failed for dn=domainName=mydomain.com,o=domains,dc=mydomain,dc=com. Bad search filter (POST /mail/?_task=mail&_action=autocomplete)
Jul 9 17:51:02 mail journal: ool www: <pij0jmsk> C: Close
Jul 9 17:51:05 mail postfix/submission/smtpd[41063]: connect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:05 mail postfix/submission/smtpd[41063]: Anonymous TLS connection established from mail.mydomain.com[127.0.0.1]: TLSv1 with cipher ECDHE-RSA-AES256-SHA (256/256 bits)
Jul 9 17:51:05 mail postfix/submission/smtpd[41063]: E9E6B9800154E: client=mail.mydomain.com[127.0.0.1], sasl_method=LOGIN, sasl_username=bbbb@mydomain.com
Jul 9 17:51:05 mail postfix/cleanup[41065]: E9E6B9800154E: message-id=<c1ef861d81420e129912a9c376b4b305@mydomain.com>
Jul 9 17:51:05 mail opendmarc[1382]: E9E6B9800154E: SPF(mailfrom): bbbb@mydomain.com pass
Jul 9 17:51:05 mail opendmarc[1382]: E9E6B9800154E: mydomain.com pass
Jul 9 17:51:06 mail roundcube: <pij0jmsk> User bbbb@mydomain.com [203.xx.xx.xx]; Message for aaaa@mydomain.com; 250: 2.0.0 Ok: queued as E9E6B9800154E
Jul 9 17:51:06 mail postfix/qmgr[2054]: E9E6B9800154E: from=<bbbb@mydomain.com>, size=2642, nrcpt=2 (queue active)
Jul 9 17:51:06 mail postfix/submission/smtpd[41063]: disconnect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:06 mail amavis[34781]: (34781-13) ESMTP [127.0.0.1]:10026 /var/spool/amavisd/tmp/amavis-20180709T171257-34781-Olayc3aO: <bbbb@mydomain.com> -> <aaaa@mydomain.com> Received: from mail.mydomain.com ([127.0.0.1]) by mail.mydomain.com (mail.mydomain.com [127.0.0.1]) (amavisd-new, port 10026) with ESMTP for <aaaa@mydomain.com>; Mon, 9 Jul 2018 17:51:06 +0800 (CST)
Jul 9 17:51:06 mail amavis[19793]: (19793-15) ESMTP [127.0.0.1]:10026 /var/spool/amavisd/tmp/amavis-20180709T115847-19793-Td1pZR5X: <bbbb@mydomain.com> -> <mydomainadmin@mydomain.com> Received: from mail.mydomain.com ([127.0.0.1]) by mail.mydomain.com (mail.mydomain.com [127.0.0.1]) (amavisd-new, port 10026) with ESMTP for <mydomainadmin@mydomain.com>; Mon, 9 Jul 2018 17:51:06 +0800 (CST)
Jul 9 17:51:06 mail amavis[34781]: (34781-13) Checking: 9DZ0CO5LmDxK ORIGINATING/MYNETS [127.0.0.1] <bbbb@mydomain.com> -> <aaaa@mydomain.com>
Jul 9 17:51:06 mail clamd[2649]: SelfCheck: Database status OK.
Jul 9 17:51:06 mail amavis[19793]: (19793-15) Checking: 9_YNk6W7qsys ORIGINATING/MYNETS [127.0.0.1] <bbbb@mydomain.com> -> <mydomainadmin@mydomain.com>
Jul 9 17:51:07 mail postfix/10025/smtpd[41075]: connect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/10025/smtpd[41075]: 515379800154F: client=mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/cleanup[41065]: 515379800154F: message-id=<c1ef861d81420e129912a9c376b4b305@mydomain.com>
Jul 9 17:51:07 mail postfix/10025/smtpd[41076]: connect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/10025/smtpd[41076]: 54AE498001550: client=mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/cleanup[41079]: 54AE498001550: message-id=<c1ef861d81420e129912a9c376b4b305@mydomain.com>
Jul 9 17:51:07 mail opendmarc[1382]: 515379800154F: SPF(mailfrom): bbbb@mydomain.com pass
Jul 9 17:51:07 mail opendmarc[1382]: 515379800154F: mydomain.com pass
Jul 9 17:51:07 mail opendmarc[1382]: 54AE498001550: SPF(mailfrom): bbbb@mydomain.com pass
Jul 9 17:51:07 mail opendmarc[1382]: 54AE498001550: mydomain.com pass
Jul 9 17:51:07 mail postfix/10025/smtpd[41075]: disconnect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/qmgr[2054]: 515379800154F: from=<bbbb@mydomain.com>, size=4001, nrcpt=1 (queue active)
Jul 9 17:51:07 mail amavis[19793]: (19793-15) 9_YNk6W7qsys FWD from <bbbb@mydomain.com> -> <mydomainadmin@mydomain.com>, BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 515379800154F
Jul 9 17:51:07 mail amavis[19793]: (19793-15) Passed CLEAN {RelayedInternal}, ORIGINATING/MYNETS LOCAL [127.0.0.1]:6130 <bbbb@mydomain.com> -> <mydomainadmin@mydomain.com>, Queue-ID: E9E6B9800154E, Message-ID: <c1ef861d81420e129912a9c376b4b305@mydomain.com>, mail_id: 9_YNk6W7qsys, Hits: 0.213, size: 3010, queued_as: 515379800154F, dkim_new=dkim:mydomain.com, 1367 ms, Tests: [ALL_TRUSTED=-1,SPF_PASS=-0.001,TVD_RCVD_SINGLE=1.213,URIBL_BLOCKED=0.001]
Jul 9 17:51:07 mail amavis[19793]: (19793-15) Passed CLEAN, <bbbb@mydomain.com> -> <mydomainadmin@mydomain.com>, Hits: 0.213, tag=2, tag2=6.2, kill=6.9, queued_as: 515379800154F, L/0/0/0
Jul 9 17:51:07 mail amavis[34781]: (34781-13) 9DZ0CO5LmDxK FWD from <bbbb@mydomain.com> -> <aaaa@mydomain.com>, BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 54AE498001550
Jul 9 17:51:07 mail postfix/qmgr[2054]: 54AE498001550: from=<bbbb@mydomain.com>, size=3985, nrcpt=1 (queue active)
Jul 9 17:51:07 mail amavis[34781]: (34781-13) Passed CLEAN {RelayedInternal}, ORIGINATING/MYNETS LOCAL [127.0.0.1]:6130 <bbbb@mydomain.com> -> <aaaa@mydomain.com>, Queue-ID: E9E6B9800154E, Message-ID: <c1ef861d81420e129912a9c376b4b305@mydomain.com>, mail_id: 9DZ0CO5LmDxK, Hits: 0.213, size: 3010, queued_as: 54AE498001550, dkim_new=dkim:mydomain.com, 1387 ms, Tests: [ALL_TRUSTED=-1,SPF_PASS=-0.001,TVD_RCVD_SINGLE=1.213,URIBL_BLOCKED=0.001]
Jul 9 17:51:07 mail amavis[34781]: (34781-13) Passed CLEAN, <bbbb@mydomain.com> -> <aaaa@mydomain.com>, Hits: 0.213, tag=2, tag2=6.2, kill=6.9, queued_as: 54AE498001550, L/0/0/0
Jul 9 17:51:07 mail postfix/10025/smtpd[41076]: disconnect from mail.mydomain.com[127.0.0.1]
Jul 9 17:51:07 mail postfix/amavis/smtp[41070]: E9E6B9800154E: to=<mydomainadmin@mydomain.com>, relay=127.0.0.1[127.0.0.1]:10026, delay=1.6, delays=0.13/0.03/0/1.4, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 515379800154F)
Jul 9 17:51:07 mail postfix/amavis/smtp[41067]: E9E6B9800154E: to=<aaaa@mydomain.com>, relay=127.0.0.1[127.0.0.1]:10026, delay=1.6, delays=0.13/0.02/0/1.4, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 54AE498001550)
Jul 9 17:51:07 mail postfix/qmgr[2054]: E9E6B9800154E: removed
Jul 9 17:51:07 mail postfix/pipe[41080]: 515379800154F: to=<mydomainadmin@mydomain.com>, relay=dovecot, delay=0.29, delays=0.13/0.02/0/0.14, dsn=2.0.0, status=sent (delivered via dovecot service)
Jul 9 17:51:07 mail postfix/qmgr[2054]: 515379800154F: removed
Jul 9 17:51:07 mail postfix/pipe[41081]: 54AE498001550: to=<aaaa@mydomain.com>, relay=dovecot, delay=0.29, delays=0.13/0.01/0/0.15, dsn=2.0.0, status=sent (delivered via dovecot service)
Jul 9 17:51:07 mail postfix/qmgr[2054]: 54AE498001550: removed