Every time i try to log in via Web Interface with certain users.
Jan 29 23:06:46 sogod [15880]: <0x0x2ab99fd09948[NGLdapConnection]>
Using ldap_init (deprecated) for LDAP host:port 127.0.0.1:389
Jan 29 23:06:46 sogod [15880]: <0x0x2ab99f141168[NGLdapConnection]>
Using ldap_init (deprecated) for LDAP host:port 127.0.0.1:389
2013-01-29 23:06:46.740 sogod[15880] -[NGLdapConnection
_searchAtBaseDN:qualifier:attributes:scope:]: search with at base
filter for attrs `h
an 29 23:06:46 sogod [15880]: <0x0x2ab99fd09948[NGLdapConnection]>
Using ldap_init (deprecated) for LDAP host:port 127.0.0.1:389
Jan 29 23:06:46 sogod [15880]: SOGoRootPage successful login for user
'[email protected]' - expire = -1 grace = -1
First Auth attempt works
Jan 29 23:06:46 sogod [15880]: <0x0x2ab99fc420c8[NGLdapConnection]>
Using ldap_init (deprecated) for LDAP host:port 127.0.0.1:389
2013-01-29 23:06:46.753 sogod[15880] -[NGLdapConnection
_searchAtBaseDN:qualifier:attributes:scope:]: search with at base
filter for attrs `h
1.19.158.172 - - [29/Jan/2013:23:06:46 GMT] "POST /SOGo/connect
HTTP/1.1" 200 27/74 0.023 - - 0
Jan 29 23:06:47 sogod [15880]: <0x0x2ab99f1b13d8[NGLdapConnection]>
Using ldap_init (deprecated) for LDAP host:port 127.0.0.1:389
Jan 29 23:06:47 sogod [15880]: <0x0x2ab99f13acd8[LDAPSource]>
<NSException: 0x2ab99fb50df8> NAME:LDAPException REASON:operation bind
failed: Invalid credentials (0x31) INFO:{login =
"uid=some,dc=where,dc=de"; }
Jan 29 23:06:47 sogod [15880]:
<0x0x2ab99f1b4e38[SOGoWebAuthenticator]> tried wrong password for user
'zjWxFWqXYqq73sXtuvpkJXtSWLejQwwWH9PnUe4Ahb9SwY61eb/Fn/h1IxwISRHjEm6eEfZUPZexRhL2WnQ5oQ=='!
Then something goes wrong. I dont even know where this strange string
comes from.
31.19.158.172 - - [29/Jan/2013:23:06:47 GMT] "GET /SOGo/[email protected]
HTTP/1.1" 200 4358/0 0.019 12340 64% 0
Then out of nowhere after several serial attempts (around 4 or 5) the
login works and the log shows this.
Jan 29 23:22:19 sogod [15880]: SOGoRootPage successful login for user
'[email protected]' - expire = -1 grace = -1
31.19.158.172 - - [29/Jan/2013:23:22:19 GMT] "POST /SOGo/connect
HTTP/1.1" 200 27/74 0.007 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:19 GMT] "GET /SOGo/[email protected]
HTTP/1.1" 302 0/0 0.003 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:20 GMT] "GET
/SOGo/[email protected]/view HTTP/1.1" 302 0/0 0.010 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:20 GMT] "GET
/SOGo/so/[email protected]/Mail HTTP/1.1" 302 0/0 0.003 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:21 GMT] "GET
/SOGo/so/[email protected]/Mail/view HTTP/1.1" 200 9672/0 0.337 33136 70% 0
31.19.158.172 - - [29/Jan/2013:23:22:23 GMT] "POST
/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1359498142
HTTP/1.1" 200 2/0 0.035 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:23 GMT] "POST
/SOGo/so/[email protected]/Mail/0/mailboxes HTTP/1.1" 200 333/0 0.226 - - 0
31.19.158.172 - - [29/Jan/2013:23:22:23 GMT] "POST
/SOGo/so/[email protected]/Mail/1/mailboxes HTTP/1.1" 200 333/0 0.299 - - 624K
31.19.158.172 - - [29/Jan/2013:23:22:24 GMT] "POST
/SOGo/so/[email protected]/Mail/2/mailboxes HTTP/1.1" 200 333/0 0.285 - - 536K
31.19.158.172 - - [29/Jan/2013:23:22:25 GMT] "POST
/SOGo/so/[email protected]/Mail/3/mailboxes HTTP/1.1" 200 333/0 0.285 - - 576K
What could be wrong? Why is this phenomen only occurring for certain users?
Auth source is ldap which is working fine with dovecot alone and with
the tb integration. Only the web interface seems to fuzz around.
mfg Hagen
--
[email protected]
https://inverse.ca/sogo/lists
