>Dec 19 14:01:17 home postfix/smtpd[3066]: connect from localhost[127.0.0.1]
>Dec 19 14:01:17 home postfix/smtpd[3066]: 5398120ED0: client=localhost[127.0.0.1]
>Dec 19 14:01:17 home postfix/cleanup[3071]: 5398120ED0: message-id=<20091219090117.5398120ED0@chebyrashka59r.ru>
>Dec 19 14:01:17 home postfix/smtpd[3066]: disconnect from localhost[127.0.0.1]
>Dec 19 14:01:17 home postfix/qmgr[3031]: 5398120ED0: from=<Froggy@chebyrashka59r.ru>, size=622, nrcpt=1 (queue active)Поймали письмо "поздравляем с регистрацией", отправленное postfixadmin.
Это письмо необходимо, чтобы создались директории почтового ящика.
Без них imap-у заходить будет некуда.
AFAIK, корневую директорию пользовательского почтового ящика он никогда не создает.
>Dec 19 14:01:21 home postfix/pickup[3032]: 53AF820ED6: uid=5001 from=<Froggy@chebyrashka59r.ru>
>Dec 19 14:01:21 home postfix/pipe[3072]: 5398120ED0: to=<testbox10@chebyrashka59r.ru>, relay=spamassassin, delay=4, delays=0.06/0.01/0/4, dsn=2.0.0, status=sent
>(delivered via spamassassin service)
>Dec 19 14:01:21 home postfix/qmgr[3031]: 5398120ED0: removed
>Dec 19 14:01:21 home postfix/cleanup[3071]: 53AF820ED6: message-id=<20091219090117.5398120ED0@chebyrashka59r.ru>
>Dec 19 14:01:21 home postfix/qmgr[3031]: 53AF820ED6: from=<Froggy@chebyrashka59r.ru>, size=911, nrcpt=1 (queue active)
Письмо (5398120ED0) пошло на спам-фильтр. Болтается где-то в нем. В это время, спам фильтр открывает соединение, чтобы бросить профильтрованное письмо (53AF820ED6).
Теперь оно уже попадает на clamsmtpd. С выхода антивируса ожидаем новое письмо, идентификатор 7008B20ED0.
>Dec 19 14:01:21 home clamsmtpd: 100000: accepted connection from: 127.0.0.1
>Dec 19 14:01:21 home postfix/smtpd[3079]: connect from localhost[127.0.0.1]
>Dec 19 14:01:21 home postfix/smtpd[3079]: 7008B20ED0: client=localhost[127.0.0.1]
>Dec 19 14:01:21 home postfix/cleanup[3071]: 7008B20ED0: message-id=<20091219090117.5398120ED0@chebyrashka59r.ru>
>Dec 19 14:01:21 home postfix/qmgr[3031]: 7008B20ED0: from=<Froggy@chebyrashka59r.ru>, size=1146, nrcpt=1 (queue active)
>Dec 19 14:01:21 home clamsmtpd: 100000: from=Froggy@chebyrashka59r.ru, to=testbox10@chebyrashka59r.ru, status=CLEAN
Антивирус проверил письмо. чисто. Отдает письмо (7008B20ED0) постфиксу.
>Dec 19 14:01:21 home postfix/smtp[3077]: 53AF820ED6: to=<testbox10@chebyrashka59r.ru>, relay=127.0.0.1[127.0.0.1]:10026, delay=0.27, delays=0.09/0.02/0.06/0.1, d
>sn=2.0.0, status=sent (250 2.0.0 Ok: queued as 7008B20ED0)
>Dec 19 14:01:21 home postfix/smtpd[3079]: disconnect from localhost[127.0.0.1]
>Dec 19 14:01:21 home postfix/qmgr[3031]: 53AF820ED6: removed
Постфикс получает 7008B20ED0. Соответственно, получив успех, антивирус говорит, что письмо (53AF820ED6) доставлено.
>Dec 19 14:01:21 home dovecot: auth(default): master in: USER#0111#011testbox10@chebyrashka59r.ru#011service=deliver
>Dec 19 14:01:21 home dovecot: auth-worker(default): mysql: Connected to localhost (mail)
>Dec 19 14:01:21 home dovecot: auth-worker(default): sql(testbox10@chebyrashka59r.ru): SELECT '/home/mail/chebyrashka59r.ru/testbox10' as home, 'maildir:/home/mail/chebyrashka59r.ru/testbox10' as mail, 150 AS uid, 8 AS gid, concat('dirsize:storage=', quota) AS quota FROM mailbox WHERE username = 'testbox10@chebyrashka59r.ru' AND active = '1'
>Dec 19 14:01:21 home dovecot: auth(default): master out: USER#0111#011testbox10@chebyrashka59r.ru#011home=/home/mail/chebyrashka59r.ru/testbox10#011mail=maildir:/home/mail/chebyrashka59r.ru/testbox10#011uid=150#011gid=8#011quota=dirsize:storage=0
Эмм, тут я думал, что в этот момент происходит подключение postfixadmin-а к имапу.
Но, тут происходит доставка письма в ящик средствами сервиса dovecot, а не imap-подключение.
>Dec 19 14:01:21 home deliver(testbox10@chebyrashka59r.ru): msgid=<20091219090117.5398120ED0@chebyrashka59r.ru>: saved mail to INBOX
>Dec 19 14:01:21 home postfix/pipe[3081]: 7008B20ED0: to=<testbox10@chebyrashka59r.ru>, relay=dovecot, delay=0.31, delays=0.09/0.01/0/0.21, dsn=2.0.0, status=sent
> (delivered via dovecot service)
>Dec 19 14:01:21 home postfix/qmgr[3031]: 7008B20ED0: removed
Так что, да - действительно, судя по логу получается, что postfixadmin не стучится по имапу для создания ящиков, и надо дебажить именно его...
Следует ковырять код и вставлять какую-то отладку...
Вообще, доступ по imap к ящикам отлажен и работает?