[horde] Very slow login times with IMP-CVS+Cyrus+MySQL

[Josh Endries]

Hello,

I installed the CVS version of Horde and IMP on a server and Horde is 
taking a very long time (~1.5 minutes) to log in to the Cyrus IMAP 
server (IMP does the auth). The server also takes a very long time to 
compose/send email after submitting (to a 127.0.0.1 Postfix SMTP 
server). I can use a normal IMAP client like Thunderbird just fine 
with no delays, and can login manually over telnet without 
problems... I'm currently using imapproxyd to pool the IMAP 
connections, but removing that doesn't change what happens (I tried). 
It doesn't take long to login when using IMP's test.php, and the logs 
make it look like it logs in okay right away, then it just sits there 
doing nothing for a minute, then PHP realizes that it logged in and 
comes alive again. Any ideas as to the problem or other things to 
test would be helpful.

This is all the logging I can think of grabbing (mysql, horde, and 
syslog):

040822 15:51:03    6732 Connect     horde at 127.0.0.1 on
                    6732 Init DB     horde
Aug 22 15:51:04 HORDE [debug] [imp] SQL Query by 
Prefs_sql::retrieve(): SELECT pref_scope, pref_name, pref_value FROM 
horde_prefs WHERE pref_uid = 'josh' AND (pref_scope = 'imp' OR 
pref_scope = 'horde') ORDER BY pref_scope [on line 147 of 
"/usr/local/lib/php/Horde/Prefs/sql.php"]
040822 15:51:04    6732 Init DB     horde
                    6732 Init DB     horde
                    6732 Query       SELECT pref_scope, pref_name, 
pref_value FROM horde_prefs WHERE pref_uid = 'josh' AND (pref_scope = 
'imp' OR pref_scope = 'horde') ORDER BY pref_scope
Aug 22 15:51:04 www master[5906]: about to exec 
/usr/local/cyrus/bin/imapd
Aug 22 15:51:04 www imap[5906]: executed
Aug 22 15:51:04 www imap[5906]: accepted connection
Aug 22 15:51:04 www imap[5906]: login: localhost [127.0.0.1] josh 
plaintext User logged in
Aug 22 15:51:04 www in.imapproxyd[555]: LOGIN: 'josh' 
(127.0.0.1:52402) on new sd [10]
Aug 22 15:52:24 HORDE [notice] [imp] Login success for josh 
[68.172.187.152] to {127.0.0.1:10143} [on line 117 of 
"/var/www/www.endries.org/horde/imp/redirect.php"]
Aug 22 15:52:24 www in.imapproxyd[555]: LOGOUT: 'josh' from server sd 
[10]
Aug 22 15:52:24 www in.imapproxyd[555]: LOGIN: 'josh' 
(127.0.0.1:52406) on existing sd [10]
Aug 22 15:52:24 www imap[5906]: seen_db: user josh opened 
/var/imap/user/j/josh.seen
Aug 22 15:52:24 www in.imapproxyd[555]: LOGOUT: 'josh' from server sd 
[10]
040822 15:52:24    6732 Init DB     horde
                    6732 Query       SELECT 1 FROM horde_prefs WHERE 
pref_uid = 'josh' AND pref_name = 'last_login' AND (pref_scope = 
'horde' OR pref_scope = 'horde')
                    6732 Init DB     horde
                    6732 Query       UPDATE horde_prefs SET 
pref_value = 
'a:2:{s:4:\"time\";i:1093204264;s:4:\"host\";s:14:\"68.172.187.152\";}' 
WHERE pref_uid = 'josh' AND pref_name = 'last_login' AND pref_scope = 
'horde'
                    6732 Quit

Thanks,
Josh