Can't login Horde (no error message)
d4ndy
d4ndy at autistici.org
Tue Mar 29 09:47:10 CEST 2011
This is a test installation in my lan.
I try to install kolab for three time with same result.
VMWare machine with Ubuntu server 10.4
Kolab 2.2.4 in OpenPKG environment just installed from source
cat /etc/hosts
127.0.0.1 localhost
192.168.1.250 acenmail.acen.local acenmail
# The following lines are desirable for IPv6 capable hosts
::1 localhost ip6-localhost ip6-loopback
fe00::0 ip6-localnet
ff00::0 ip6-mcastprefix
ff02::1 ip6-allnodes
ff02::2 ip6-allrouters
cat ./var/kolab/www/client/config/kolab.php | grep cookie
$conf['cookie']['domain'] = 'acenmail.acen.local';
$conf['cookie']['path'] = '/client';
cat ./var/kolab/www/client/config/conf.php | grep cookie
$conf['session']['use_only_cookies'] = true;
$conf['cookie']['domain'] = $_SERVER['SERVER_NAME'];
$conf['cookie']['path'] = '/';
tail -f ./var/imapd/log/imapd.log
Mar 29 00:09:05 acenmail <debug> imap[3458]: accepted connection
Mar 29 00:09:05 acenmail <debug> imap[3458]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <debug> imap[3458]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <notice> imap[3458]: login: acenmail.acen.local
[192.168.1.250] acen at pippo.com PLAIN User logged in
Mar 29 00:09:05 acenmail <debug> imap[3465]: executed
Mar 29 00:09:05 acenmail <debug> imap[3465]: accepted connection
Mar 29 00:09:05 acenmail <debug> imap[3465]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <debug> imap[3465]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <notice> imap[3465]: login: acenmail.acen.local
[192.168.1.250] acen at pippo.com PLAIN User logged in
Mar 29 00:09:05 acenmail <debug> imap[3465]: seen_db: user
acen at pippo.com opened /kolab/var/imapd/domain/a/pippo.com/user/a/acen.seen
Mar 29 00:09:05 acenmail <debug> imap[3465]: open: user acen at pippo.com
opened INBOX
Mar 29 00:09:05 acenmail <debug> imap[3466]: executed
Mar 29 00:09:05 acenmail <debug> imap[3466]: accepted connection
Mar 29 00:09:05 acenmail <debug> imap[3466]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <debug> imap[3466]: canonify: 'acen at pippo.com'
Mar 29 00:09:05 acenmail <notice> imap[3466]: login: acenmail.acen.local
[192.168.1.250] acen at pippo.com PLAIN User logged in
Mar 29 00:09:05 acenmail <debug> imap[3465]: accepted connection
Mar 29 00:09:05 acenmail <debug> imap[3458]: accepted connection
Mar 29 00:09:05 acenmail <debug> imap[3466]: accepted connection
tail -f ./var/kolab/www/client/log/horde.log
Mar 29 00:09:04 HORDE [debug] [imp] Hook _prefs_change_hook_last_login
in application horde not called. [pid 16191 on line 1683 of
"/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [notice] [imp] Login success for acen at pippo.com
[192.168.1.100] to {acenmail.acen.local:143
[imap/notls/novalidate-cert]} [pid 16191 on line 304 of
"/kolab/var/kolab/www/client/imp/lib/Session.php"]
Mar 29 00:09:05 HORDE [debug] [imp] Hook
_prefs_change_hook_last_maintenance in application horde not called.
[pid 16191 on line 1683 of "/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [debug] [imp] Max memory usage: 11010048 bytes
[pid 16191 on line 339 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
Mar 29 00:09:05 HORDE [debug] [imp] IMAP errors: SECURITY PROBLEM:
insecure server advertised AUTH=PLAIN SECURITY PROBLEM: insecure server
advertised AUTH=PLAIN [pid 16191 on line 175 of
"/kolab/var/kolab/www/client/imp/lib/IMAP.php"]
Mar 29 00:09:05 HORDE [debug] [horde] Max memory usage: 4980736 bytes
[pid 16191 on line 339 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
Mar 29 00:09:05 HORDE [debug] [horde] Max memory usage: 4980736 bytes
[pid 16191 on line 339 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Hook _horde_hook_share_init in
application horde not called. [pid 16191 on line 1683 of
"/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [error] [kronolith] Errore IMAP. Server:
acenmail.acen.local. Errore: IMAP Authentication cancelled [pid 16191 on
line 1330 of "/kolab/var/kolab/www/client/kronolith/lib/Kronolith.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Hook
_prefs_change_hook_display_remote_cals in application horde not called.
[pid 16191 on line 1683 of "/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Guest user does not have READ
permission for turba [pid 16191 on line 814 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Guest user does not have READ
permission for nag [pid 16191 on line 814 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Hook
_prefs_change_hook_display_external_cals in application horde not
called. [pid 16191 on line 1683 of
"/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [debug] [kronolith] Hook
_prefs_change_hook_display_cals in application horde not called. [pid
16191 on line 1683 of "/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [debug] [nag] Hook _horde_hook_share_init in
application horde not called. [pid 16191 on line 1683 of
"/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [error] [nag] Errore IMAP. Server:
acenmail.acen.local. Errore: IMAP Authentication cancelled [pid 16191 on
line 281 of "/kolab/var/kolab/www/client/nag/lib/Nag.php"]
Mar 29 00:09:05 HORDE [error] [nag] Errore IMAP. Server:
acenmail.acen.local. Errore: IMAP Authentication cancelled [pid 16191 on
line 281 of "/kolab/var/kolab/www/client/nag/lib/Nag.php"]
Mar 29 00:09:05 HORDE [debug] [nag] Hook
_prefs_change_hook_display_tasklists in application horde not called.
[pid 16191 on line 1683 of "/kolab/var/kolab/www/client/lib/Horde.php"]
Mar 29 00:09:05 HORDE [debug] [imp] SQL query by
Horde_Alarm_sql::_list(): SELECT alarm_id, alarm_uid, alarm_start,
alarm_end, alarm_methods, alarm_params, alarm_title, alarm_text,
alarm_snooze, alarm_internal FROM horde_alarms WHERE alarm_dismissed = 0
AND ((alarm_snooze IS NULL AND alarm_start <= ?) OR alarm_snooze <= ?)
AND (alarm_end IS NULL OR alarm_end >= ?) AND (alarm_uid = ? OR
alarm_uid = ?) ORDER BY alarm_start, alarm_end [pid 16191 on line 148 of
"/kolab/var/kolab/www/client/lib/Horde/Alarm/sql.php"]
Mar 29 00:09:05 HORDE [debug] [imp] Max memory usage: 11796480 bytes
[pid 16191 on line 339 of
"/kolab/var/kolab/www/client/lib/Horde/Registry.php"]
tail -f ./var/kolab/www/client/log/php-errors.log
[29-Mar-2011 00:09:05] PHP Notice: Unknown: SECURITY PROBLEM: insecure
server advertised AUTH=PLAIN (errflg=1) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP protocol error: Client
canceled authentication (errflg=2) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP Authentication
cancelled (errflg=2) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: SECURITY PROBLEM: insecure
server advertised AUTH=PLAIN (errflg=1) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP protocol error: Client
canceled authentication (errflg=2) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP Authentication
cancelled (errflg=2) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: SECURITY PROBLEM: insecure
server advertised AUTH=PLAIN (errflg=1) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP protocol error: Client
canceled authentication (errflg=2) in Unknown on line 0
[29-Mar-2011 00:09:05] PHP Notice: Unknown: IMAP Authentication
cancelled (errflg=2) in Unknown on line 0
And sometimes I've also this error:
./var/sasl/log/saslauthd.log
Mar 28 23:55:47 acenmail <debug> saslauthd[1387]: ldap_simple_bind()
failed -1 (Can't contact LDAP server).
Mar 28 23:55:47 acenmail <info> saslauthd[1387]: Retrying authentication
Mar 28 23:55:47 acenmail <error> saslauthd[1370]: user ldap_search_st()
failed: Can't contact LDAP server
Mar 28 23:55:47 acenmail <info> saslauthd[1370]: Retrying authentication
Thank you very much.
More information about the users
mailing list