[RCU] Login failing, Dovecot shows login followed by logout

James Brown jlbrown at bordo.com.au
Wed Jul 24 10:08:58 CEST 2019


OK, managed to get logging working after adding:

$config['log_logins'] = 'true';
$config['log_session'] = 'yes';
$config['imap_debug'] = 'yes';
$config['log_driver'] = 'file';

When I try to login I now see this:

 Error in /Library/Webserver/Documents/roundcube/program/lib/Roundcube/rcube_db.php (543): [1364] Field 'alias' doesn't have a default value (SQL Query: INSERT INTO `users` (`created`, `last_login`, `username`, `mail_host`, `language`) VALUES (now(), now(), ‘myuser at bordo.com.au', 'mail.bordo.com.au', 'en_US'))
PHP Error in /Library/Webserver/Documents/roundcube/program/lib/Roundcube/rcube_user.php (688): Failed to create new user
PHP Error in /Library/Webserver/Documents/roundcube/program/include/rcmail.php (652): Failed to create a user record. Maybe aborted by a plugin?

Logs/imap has:

[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: * OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ AUTH=PLAIN] Dovecot ready.
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] C: A0001 ID ("name" "Roundcube" "version" "1.3.9" "php" "7.3.7" "os" "Darwin" "command" "/roundcube/?_task=login")
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: * ID ("name" "Dovecot")
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: A0001 OK ID completed.
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] C: A0002 AUTHENTICATE PLAIN ****** [53]
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: A0002 OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY LITERAL+ NOTIFY SPECIAL-USE] Logged in
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] C: A0003 NAMESPACE
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: * NAMESPACE (("" ".")) NIL NIL
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: A0003 OK Namespace completed (0.001 + 0.000 secs).
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] C: A0004 LOGOUT
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: * BYE Logging out
[24-Jul-2019 07:35:53 +0000]: <pg7kv1kp> [6E3B] S: A0004 OK Logout completed (0.001 + 0.000 secs).
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: * OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ AUTH=PLAIN] Dovecot ready.
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] C: A0001 ID ("name" "Roundcube" "version" "1.3.9" "php" "7.3.7" "os" "Darwin" "command" "/roundcube/?_task=login")
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: * ID ("name" "Dovecot")
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: A0001 OK ID completed.
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] C: A0002 AUTHENTICATE PLAIN ****** [53]
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: A0002 OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY LITERAL+ NOTIFY SPECIAL-USE] Logged in
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] C: A0003 NAMESPACE
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: * NAMESPACE (("" ".")) NIL NIL
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: A0003 OK Namespace completed (0.001 + 0.000 secs).
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] C: A0004 LOGOUT
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: * BYE Logging out
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> [2773] S: A0004 OK Logout completed (0.001 + 0.000 secs).

Logs/userlogins has:

[24-Jul-2019 07:52:15 +0000]: <pg7kv1kp> Failed login for myuser at bordo.com.au from 192.168.1.27 in session pg7kv1kplhbj81992hl94qht0m (error: 1)
[24-Jul-2019 07:52:19 +0000]: <pg7kv1kp> Failed login for myuser at bordo.com.au from 192.168.1.27 in session pg7kv1kplhbj81992hl94qht0m (error: 0)

So looks like the problem is that it can’t add anything to the ‘alias’ field?

How can I fix that?

Many thanks,

James.


On 23 Jul 2019, at 11:52 pm, James Brown <jlbrown at bordo.com.au> wrote:
> 
> Running Roundcube 1.3.9, Dovecot 2.3.6 and mySQL 5.7.26
> 
> Dovecot log:
> 
> Jul 23 23:07:15 imap-login: Info: Login: user=<myuser at bordo.com.au>, method=PLAIN, rip=192.168.1.27, lip=192.168.1.9, mpid=32877, TLS, session=<dJoh34iOicjAqAEb>
> Jul 23 23:07:15 imap(myuser at bordo.com.au)<32877><dJoh34iOicjAqAEb>: Info: Logged out in=29 out=529 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
> 
> But Roundcube web login page says:
> 
> Login failed.
> 
> Nothing is logged to Roundcube’s logs. 
> 
> Any suggestions?
> 
> Thanks,
> 
> James.
> _______________________________________________
> Roundcube Users mailing list
> users at lists.roundcube.net
> http://lists.roundcube.net/mailman/listinfo/users

-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/pkcs7-signature
Size: 3893 bytes
Desc: not available
URL: <http://lists.roundcube.net/pipermail/users/attachments/20190724/68a09463/attachment.p7s>


More information about the users mailing list