View Issue Details

Jump to NotesJump to History
IDProjectCategoryView StatusDate SubmittedLast Update
0001175SOGoWeb Generalpublic2011-03-09 00:032011-04-11 20:30
Reportermjevans Assigned Toludovic  
PrioritynormalSeverityblockReproducibilityalways
Status resolvedResolutionno change required 
Product Versionnightly v2 
Summary0001175: SOGo install issues, crash with NSException NSInvalidArgumentException REASON:GSMutableDictionar; doc. potentially the problem?
Description

As far as I can tell I've setup everything requested in the documentation. The error logs are less than helpful.

The /only/ thing in the setup procedure I did not do was create additional LDAP (Active Directory) accounts; I expect to use existing accounts for administration.

My current working theory is:
1) That SOGo's documentation does not
1.a) explain what the default administrative account is named ( sogo I think )
1.b) describe a configuration parameter that can be used to select a different account name, or even better some type of entity (membership in a group would be ideal).
2) sogo.log, even with all the undocumented debugging things I found via searches does not provide sufficient detail to reach the above conclusion from just the log information; it does not describe /what/ it is trying to do when it fails, particularly not printing involved values.

I am trying to map all valid login names in the Active Directory on to mailboxes in the form of login.name@* if a mailbox exists by that name on the mail server.

Thus if there is a user john.smith with password newworld he would be able to log in to the accounts john.smith@site-1.com and john.smith@site2.net with the same password as his network account.

Additional Information

Try with firefox and then wget.

wget -O- http://10.x.x.x:20000/SOGo/
--2011-03-08 15:39:13-- http://10.x.x.x:20000/SOGo/
Connecting to 10.x.x.x:20000... connected.
HTTP request sent, awaiting response... No data received.
Retrying.

Mar 08 15:38:28 sogod [16096]: [WARN] <0x0x200c2a0[WOWatchDog]> 'WOHttpAllowHost' is ignored in watchdog mode, use a real firewall instead
Mar 08 15:38:28 sogod [16096]: <0x0x200c2a0[WOWatchDog]> listening on *:20000
Mar 08 15:38:28 sogod [16096]: <0x0x200c2a0[WOWatchDog]> watchdog process pid: 16096
Mar 08 15:38:28 sogod [16096]: <0x0x200c2a0[WOWatchDog]> preparing 1 children
Mar 08 15:38:28 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16097
Mar 08 15:38:28 sogod [16097]: <0x0x221bbc0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:38:28 sogod [16097]: <0x0x221bbc0[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:38:28 sogod [16097]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:38:28 sogod [16097]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:38:28.989 sogod[16097] PostgreSQL72 connection established: <0x0x22db620[PGConnection]: connection=0x0x22c4060>
2011-03-08 15:38:28.990 sogod[16097] PostgreSQL72 channel 0x0x22c9830 opened (connection=<0x0x22db620[PGConnection]: connection=0x0x22c4060>)
2011-03-08 15:38:28.990 sogod[16097] PG0x0x22c9830 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:38:28.995 sogod[16097] PG0x0x22c9830 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:38:28.999 sogod[16097] PG0x0x22c9830 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:38:28.1000 sogod[16097] PG0x0x22c9830 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 15:38:56 sogod [16097]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 15:38:56 sogod [16097]: <0x0x2363c20[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 15:38:56 sogod [16097]: <0x0x2363c20[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 15:38:56 sogod [16097]: |SOGo| traverse(acquire): SOGo
Mar 08 15:38:56 sogod [16097]: |SOGo| do traverse name: 'SOGo'
2011-03-08 15:38:56.125 sogod[16097] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 15:38:56.125 sogod[16097] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 15:38:56.125 sogod[16097] Note(SoObject): relative base URLs are enabled.
Mar 08 15:38:56 sogod [16097]: |SOGo| set clientObject: <SOGo[0x0x2055910]: name=SOGo>
EXCEPTION: <NSException: 0x24bac90> NAME:NSInvalidArgumentException REASON:GSMutableDictionary(instance) does not recognize objectAtIndex: INFO:(nil)
Mar 08 15:38:56 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> child 16097 exited
Mar 08 15:38:56 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> (terminated due to signal 6)
Mar 08 15:38:56 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16098
Mar 08 15:38:56 sogod [16098]: <0x0x221dea0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:38:56 sogod [16098]: <0x0x221dea0[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:38:56 sogod [16098]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:38:56 sogod [16098]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:38:56.312 sogod[16098] PostgreSQL72 connection established: <0x0x22dd5a0[PGConnection]: connection=0x0x22a06d0>
2011-03-08 15:38:56.314 sogod[16098] PostgreSQL72 channel 0x0x22cbb20 opened (connection=<0x0x22dd5a0[PGConnection]: connection=0x0x22a06d0>)
2011-03-08 15:38:56.314 sogod[16098] PG0x0x22cbb20 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:38:56.319 sogod[16098] PG0x0x22cbb20 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:38:56.323 sogod[16098] PG0x0x22cbb20 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:38:56.325 sogod[16098] PG0x0x22cbb20 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 15:38:56 sogod [16098]: |SOGo| starting method 'GET' on uri '/favicon.ico'
Mar 08 15:38:56 sogod [16098]: <0x0x232dc70[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 15:38:56 sogod [16098]: <0x0x232dc70[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 15:38:56 sogod [16098]: |SOGo| traverse(acquire): favicon.ico
Mar 08 15:38:56 sogod [16098]: |SOGo| do traverse name: 'favicon.ico'
2011-03-08 15:38:56.344 sogod[16098] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 15:38:56.345 sogod[16098] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 15:38:56.345 sogod[16098] Note(SoObject): relative base URLs are enabled.
Mar 08 15:38:56 sogod [16098]: |SOGo| traverse miss: name=favicon.ico, acquire: i=0,count=1
Mar 08 15:38:56 sogod [16098]: |SOGo| miss is last object.
Mar 08 15:38:56 sogod [16098]: |SOGo| got no error for miss.
Mar 08 15:38:56 sogod [16098]: |SOGo| Note: next object is nil, but currentObject is not callable: <SOGo[0x0x2057e30]: name=SOGo>
Mar 08 15:38:56 sogod [16098]: |SOGo| request took 0.006043 seconds to execute
work-station.local - - [08/Mar/2011:15:38:56 GMT] "GET /favicon.ico HTTP/1.1" 404 29/0 0.018 - - 432K
Mar 08 15:38:59 sogod [16098]: |SOGo| starting method 'GET' on uri '/favicon.ico'
Mar 08 15:38:59 sogod [16098]: |SOGo| traverse(acquire): favicon.ico
Mar 08 15:38:59 sogod [16098]: |SOGo| do traverse name: 'favicon.ico'
Mar 08 15:38:59 sogod [16098]: |SOGo| traverse miss: name=favicon.ico, acquire: i=0,count=1
Mar 08 15:38:59 sogod [16098]: |SOGo| miss is last object.
Mar 08 15:38:59 sogod [16098]: |SOGo| got no error for miss.
Mar 08 15:38:59 sogod [16098]: |SOGo| Note: next object is nil, but currentObject is not callable: <SOGo[0x0x2057e30]: name=SOGo>
Mar 08 15:38:59 sogod [16098]: |SOGo| request took 0.000786 seconds to execute
work-station.local - - [08/Mar/2011:15:38:59 GMT] "GET /favicon.ico HTTP/1.1" 404 29/0 0.002 - - 0
Mar 08 15:39:13 sogod [16098]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 15:39:13 sogod [16098]: |SOGo| traverse(acquire): SOGo
Mar 08 15:39:13 sogod [16098]: |SOGo| do traverse name: 'SOGo'
Mar 08 15:39:13 sogod [16098]: |SOGo| set clientObject: <SOGo[0x0x2057e30]: name=SOGo>
EXCEPTION: <NSException: 0x24ce0b0> NAME:NSInvalidArgumentException REASON:GSMutableDictionary(instance) does not recognize objectAtIndex: INFO:(nil)
Mar 08 15:39:13 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> child 16098 exited
Mar 08 15:39:13 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> (terminated due to signal 6)
Mar 08 15:39:13 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16102
Mar 08 15:39:14 sogod [16102]: <0x0x221dec0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:39:14 sogod [16102]: <0x0x221dec0[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:39:14 sogod [16102]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:39:14 sogod [16102]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:39:14.162 sogod[16102] PostgreSQL72 connection established: <0x0x22e35d0[PGConnection]: connection=0x0x22a06f0>
2011-03-08 15:39:14.164 sogod[16102] PostgreSQL72 channel 0x0x22cbb40 opened (connection=<0x0x22e35d0[PGConnection]: connection=0x0x22a06f0>)
2011-03-08 15:39:14.164 sogod[16102] PG0x0x22cbb40 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:39:14.169 sogod[16102] PG0x0x22cbb40 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:39:14.174 sogod[16102] PG0x0x22cbb40 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:39:14.176 sogod[16102] PG0x0x22cbb40 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 15:39:14 sogod [16102]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 15:39:14 sogod [16102]: <0x0x23a5860[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 15:39:14 sogod [16102]: <0x0x23a5860[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 15:39:14 sogod [16102]: |SOGo| traverse(acquire): SOGo
Mar 08 15:39:14 sogod [16102]: |SOGo| do traverse name: 'SOGo'
2011-03-08 15:39:14.995 sogod[16102] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 15:39:14.996 sogod[16102] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 15:39:14.996 sogod[16102] Note(SoObject): relative base URLs are enabled.
Mar 08 15:39:14 sogod [16102]: |SOGo| set clientObject: <SOGo[0x0x20586f0]: name=SOGo>
EXCEPTION: <NSException: 0x24cd3a0> NAME:NSInvalidArgumentException REASON:GSMutableDictionary(instance) does not recognize objectAtIndex: INFO:(nil)
Mar 08 15:39:15 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> child 16102 exited
Mar 08 15:39:15 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> (terminated due to signal 6)
Mar 08 15:39:15 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> avoiding to respawn child before 2011-03-08 15:39:18 -0800
Mar 08 15:39:18 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16103
Mar 08 15:39:18 sogod [16103]: <0x0x221f240[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:39:18 sogod [16103]: <0x0x221f240[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:39:18 sogod [16103]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:39:18 sogod [16103]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:39:18.170 sogod[16103] PostgreSQL72 connection established: <0x0x22ea960[PGConnection]: connection=0x0x22a1a60>
2011-03-08 15:39:18.170 sogod[16103] PostgreSQL72 channel 0x0x22cceb0 opened (connection=<0x0x22ea960[PGConnection]: connection=0x0x22a1a60>)
2011-03-08 15:39:18.170 sogod[16103] PG0x0x22cceb0 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:39:18.175 sogod[16103] PG0x0x22cceb0 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:39:18.179 sogod[16103] PG0x0x22cceb0 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:39:18.180 sogod[16103] PG0x0x22cceb0 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 15:39:18 sogod [16103]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 15:39:18 sogod [16103]: <0x0x23a8760[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 15:39:18 sogod [16103]: <0x0x23a8760[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 15:39:18 sogod [16103]: |SOGo| traverse(acquire): SOGo
Mar 08 15:39:18 sogod [16103]: |SOGo| do traverse name: 'SOGo'
2011-03-08 15:39:18.192 sogod[16103] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 15:39:18.192 sogod[16103] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 15:39:18.192 sogod[16103] Note(SoObject): relative base URLs are enabled.
Mar 08 15:39:18 sogod [16103]: |SOGo| set clientObject: <SOGo[0x0x205f120]: name=SOGo>
EXCEPTION: <NSException: 0x24c7c00> NAME:NSInvalidArgumentException REASON:GSMutableDictionary(instance) does not recognize objectAtIndex: INFO:(nil)
Mar 08 15:39:18 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> child 16103 exited
Mar 08 15:39:18 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> (terminated due to signal 6)
Mar 08 15:39:18 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> avoiding to respawn child before 2011-03-08 15:39:23 -0800
Mar 08 15:39:23 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16104
Mar 08 15:39:23 sogod [16104]: <0x0x221f230[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:39:23 sogod [16104]: <0x0x221f230[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:39:23 sogod [16104]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:39:23 sogod [16104]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:39:23.172 sogod[16104] PostgreSQL72 connection established: <0x0x22ea950[PGConnection]: connection=0x0x22a1a50>
2011-03-08 15:39:23.172 sogod[16104] PostgreSQL72 channel 0x0x22ccea0 opened (connection=<0x0x22ea950[PGConnection]: connection=0x0x22a1a50>)
2011-03-08 15:39:23.172 sogod[16104] PG0x0x22ccea0 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:39:23.176 sogod[16104] PG0x0x22ccea0 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:39:23.181 sogod[16104] PG0x0x22ccea0 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:39:23.182 sogod[16104] PG0x0x22ccea0 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 15:39:23 sogod [16104]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 15:39:23 sogod [16104]: <0x0x23a8750[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 15:39:23 sogod [16104]: <0x0x23a8750[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 15:39:23 sogod [16104]: |SOGo| traverse(acquire): SOGo
Mar 08 15:39:23 sogod [16104]: |SOGo| do traverse name: 'SOGo'
2011-03-08 15:39:23.194 sogod[16104] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 15:39:23.194 sogod[16104] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 15:39:23.194 sogod[16104] Note(SoObject): relative base URLs are enabled.
Mar 08 15:39:23 sogod [16104]: |SOGo| set clientObject: <SOGo[0x0x205f110]: name=SOGo>
EXCEPTION: <NSException: 0x24c7bf0> NAME:NSInvalidArgumentException REASON:GSMutableDictionary(instance) does not recognize objectAtIndex: INFO:(nil)
Mar 08 15:39:23 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> child 16104 exited
Mar 08 15:39:23 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> (terminated due to signal 6)
Mar 08 15:39:23 sogod [16096]: <0x0x2040de0[WOWatchDogChild]> avoiding to respawn child before 2011-03-08 15:39:28 -0800
Mar 08 15:39:28 sogod [16096]: <0x0x200c2a0[WOWatchDog]> child spawned with pid 16105
Mar 08 15:39:28 sogod [16105]: <0x0x221f250[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 15:39:28 sogod [16105]: <0x0x221f250[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 15:39:28 sogod [16105]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 15:39:28 sogod [16105]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 15:39:28.463 sogod[16105] PostgreSQL72 connection established: <0x0x22ea970[PGConnection]: connection=0x0x22a1a70>
2011-03-08 15:39:28.464 sogod[16105] PostgreSQL72 channel 0x0x22ccec0 opened (connection=<0x0x22ea970[PGConnection]: connection=0x0x22a1a70>)
2011-03-08 15:39:28.464 sogod[16105] PG0x0x22ccec0 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 15:39:28.468 sogod[16105] PG0x0x22ccec0 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 15:39:28.475 sogod[16105] PG0x0x22ccec0 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 15:39:28.479 sogod[16105] PG0x0x22ccec0 SQL: SELECT count() FROM sogo_email_alarms_folder

Trying to troubleshoot this, I found a query command that exercised the bind account and verified the information was correct.

ldapsearch -x -LLL -E pr=200/noprompt -h 10.x.x.x -D "cn=binddn,ou=systemusers,dc=other,dc=local" -W -b "cn=users,dc=other,dc=local" -s sub '(cn=*)' sAMAccountName

cyradm --user admin localhost
IMAP Password:localhost>
localhost> lm
INBOX (\HasChildren)
INBOX/test folder (\HasNoChildren)
user/test.user (\HasNoChildren)
user/test.user@site2.net (\HasNoChildren)

This is the more recent attempt on an Ubuntu 10.04.2 install with the nightly builds repository for sogo. (GNUstep uses XML formatting internally but these are dummy-value over-written output results that still preserve the spirit of all characters encountered.)
sogo@HOST-NAME:~$ defaults read
sogod SOGoDraftsFolderName INBOX/Drafts
sogod SOGoTrashFolderName INBOX/Trash
sogod SoSecuirtyManagerDebugEnabled YES
sogod SxVMemLimit 512
sogod SoDebugObjectTraversal YES
sogod LDAPDebugEnabled YES
sogod SOGoMailMessageCheck every_5_minutes
sogod SOGoTimeZone America/Los_Angeles
sogod OCSEMailAlarmsFolderURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_email_alarms_folder
sogod SOGoSentFolderName INBOX/Sent
sogod SOGoMailingMechanism smtp
sogod SOGoSMTPServer localhost
sogod OCSSessionsFolderURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_sessions_folder
sogod SOGoIMAPServer localhost
sogod SOGoProfileURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_user_profile
sogod OCSFolderManagerSQLDebugEnabled YES
sogod SOGoEnableEMailAlarms YES
sogod SOGoCalendarDefaultRoles '(
PublicViewer,
ConfidentialDAndTViewer
)'
sogod WODebugZipRespons NO
sogod GCSFolderDebugEnabled YES
sogod domains '{
"site-1.com" = {
SOGoMailDomain = "site-1.com";
SOGoUserSources = {
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=binddn,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = BINDPASS;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = no;
port = 389;
type = ldap;
};
};
site2.net = {
SOGoMailDomain = site2.net;
SOGoUserSources = {
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=binddn,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = BINDPASS;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = YES;
port = 389;
type = ldap;
};
};
}'

TagsNo tags attached.

Activities

ludovic

ludovic

2011-03-09 00:15

administrator   ~0002231

SOGoUserSources must be an array of dictionary - right now, it's a dictionary.
mjevans

mjevans

2011-03-09 02:43

reporter   ~0002232

Unfortunately it seems that I had valid outer syntax before, since now it ignores the domains section entirely (thus showing me what a login page should look like but...)

Mar 08 18:30:31 sogod [16494]: [WARN] <0x0x184aaf0[SOGoSystemDefaults]> expected an NSDictionary for 'domains' (ignored)
Mar 08 18:30:31 sogod [16494]: [ERROR] <0x0x1d59220[SOGoUserManager]> No authentication sources defined - nobody will be able to login. Check your defaults.

According to that 'domains' is expected to contain a Dictionary (what I had before).

Is it maybe the 'id' field for each site? I think I'm doing it right since scalars are just values, arrays of scalars are arrays, and maps/hashes/w.e. of key/value pairs are dictionaries. Everything seems to make sense but it's dieing on some unknown line.

Mar 08 18:30:24 sogod [16493]: [WARN] <0x0x1895980[WOWatchDog]> 'WOHttpAllowHost' is ignored in watchdog mode, use a real firewall instead
Mar 08 18:30:24 sogod [16493]: <0x0x1895980[WOWatchDog]> listening on *:20000
Mar 08 18:30:24 sogod [16493]: <0x0x1895980[WOWatchDog]> watchdog process pid: 16493
Mar 08 18:30:24 sogod [16493]: <0x0x1895980[WOWatchDog]> preparing 1 children
Mar 08 18:30:24 sogod [16493]: <0x0x1895980[WOWatchDog]> child spawned with pid 16494
Mar 08 18:30:24 sogod [16494]: <0x0x1aa52a0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Mar 08 18:30:24 sogod [16494]: <0x0x1aa52a0[SOGoProductLoader]> Appointments.SOGo, SchedulerUI.SOGo, PreferencesUI.SOGo, Contacts.SOGo, CommonUI.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, ContactsUI.SOGo
Mar 08 18:30:24 sogod [16494]: |SOGo| version 1.3.5 (build @vizzini.inverse.ca 201103081234) -- starting
Mar 08 18:30:24 sogod [16494]: |SOGo| vmem size check enabled: shutting down app when vmem > 512 MB
2011-03-08 18:30:24.262 sogod[16494] PostgreSQL72 connection established: <0x0x1b64d00[PGConnection]: connection=0x0x1b4d740>
2011-03-08 18:30:24.263 sogod[16494] PostgreSQL72 channel 0x0x1b52f10 opened (connection=<0x0x1b64d00[PGConnection]: connection=0x0x1b4d740>)
2011-03-08 18:30:24.263 sogod[16494] PG0x0x1b52f10 SQL: SELECT count() FROM sogo_user_profile
2011-03-08 18:30:24.268 sogod[16494] PG0x0x1b52f10 SQL: SELECT count() FROM sogo_folder_info
2011-03-08 18:30:24.273 sogod[16494] PG0x0x1b52f10 SQL: SELECT count() FROM sogo_sessions_folder
2011-03-08 18:30:24.274 sogod[16494] PG0x0x1b52f10 SQL: SELECT count() FROM sogo_email_alarms_folder
Mar 08 18:30:31 sogod [16494]: |SOGo| starting method 'GET' on uri '/SOGo/'
Mar 08 18:30:31 sogod [16494]: <0x0x1b05a40[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Mar 08 18:30:31 sogod [16494]: <0x0x1b05a40[SOGoCache]> Using host(s) 'localhost' as server(s)
Mar 08 18:30:31 sogod [16494]: |SOGo| traverse(acquire): SOGo
Mar 08 18:30:31 sogod [16494]: |SOGo| do traverse name: 'SOGo'
2011-03-08 18:30:31.355 sogod[16494] Note(SoObject): SoDebugKeyLookup is enabled!
2011-03-08 18:30:31.355 sogod[16494] Note(SoObject): SoDebugBaseURL is enabled!
2011-03-08 18:30:31.355 sogod[16494] Note(SoObject): relative base URLs are enabled.
Mar 08 18:30:31 sogod [16494]: |SOGo| set clientObject: <SOGo[0x0x18deff0]: name=SOGo>
Mar 08 18:30:31 sogod [16494]: [WARN] <0x0x184aaf0[SOGoSystemDefaults]> expected an NSDictionary for 'domains' (ignored)
Mar 08 18:30:31 sogod [16494]: [ERROR] <0x0x1d59220[SOGoUserManager]> No authentication sources defined - nobody will be able to login. Check your defaults.
2011-03-08 18:30:31.358 sogod[16494] PG0x0x1b52f10 SQL: SELECT c_defaults FROM sogo_user_profile WHERE c_uid = 'anonymous'
2011-03-08 18:30:31.415 sogod[16494] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.19/Resources/SSL.bundle'
2011-03-08 18:30:31.521 sogod[16494] WOCompoundElement: pool embedding is on.
2011-03-08 18:30:31.521 sogod[16494] WOCompoundElement: id logging is on.
2011-03-08 18:30:31.546 sogod[16494] WARNING(-[NSNull(misc) count]): called NSNull -count (returns 0) !!!
Mar 08 18:30:31 sogod [16494]: |SOGo| request took 0.216740 seconds to execute

defaults read
sogod SOGoDraftsFolderName INBOX/Drafts
sogod SOGoTrashFolderName INBOX/Trash
sogod SoSecuirtyManagerDebugEnabled YES
sogod SxVMemLimit 512
sogod SoDebugObjectTraversal YES
sogod LDAPDebugEnabled YES
sogod SOGoMailMessageCheck every_5_minutes
sogod SOGoTimeZone America/Los_Angeles
sogod OCSEMailAlarmsFolderURL postgresql://sogo:PASSWORD@psql:5432/sogo/sogo_email_alarms_folder
sogod SOGoSentFolderName INBOX/Sent
sogod SOGoMailingMechanism smtp
sogod SOGoSMTPServer localhost
sogod OCSSessionsFolderURL postgresql://sogo:PASSWORD@psql:5432/sogo/sogo_sessions_folder
sogod SOGoIMAPServer localhost
sogod SOGoProfileURL postgresql://sogo:PASSWORD@psql:5432/sogo/sogo_user_profile
sogod OCSFolderManagerSQLDebugEnabled YES
sogod SOGoEnableEMailAlarms YES
sogod SOGoCalendarDefaultRoles '(
PublicViewer,
ConfidentialDAndTViewer
)'
sogod WODebugZipRespons NO
sogod GCSFolderDebugEnabled YES
sogod domains '(
{
"example-1.com" = {
SOGoMailDomain = "example-1.com";
SOGoUserSources = {
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=binddn,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = PASSWORD;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = no;
port = 389;
type = ldap;
};
};
},
{
example2.net = {
SOGoMailDomain = example2.net;
SOGoUserSources = {
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=binddn,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = PASSWORD;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = YES;
port = 389;
type = ldap;
};
};
}
)'
sogod SOGoACLsSendEMAILNotifications YES
sogod SOGoLanguage English
sogod OCSFolderInfoURL postgresql://sogo:PASSWORD@psql:5432/sogo/sogo_folder_info
sogod SOGoDebugRequests YES
sogod PGDebugEnabled YES
sogod SOGoUIxDebugEnabled YES
sogod SOGoAppointmentSendEMailNotifications YES
sogod SOGoFoldersSendEMAILNotifications YES
ludovic

ludovic

2011-03-09 13:37

administrator   ~0002234

I said that SOGoUserSources must be an array or dictionaries, not domains = ...
mjevans

mjevans

2011-03-09 18:13

reporter   ~0002236

Thank you very much, that was exactly what was wrong with the configuration.

Login works, but only for the default site (the first one?). That however would be a different bug for me to search for and resolve. If I have time later this week I'll investigate making a patch to properly log what the failure is for the admin.

sogo@HOST-NAME:~$ defaults read
sogod SOGoDraftsFolderName INBOX/Drafts
sogod SOGoTrashFolderName INBOX/Trash
sogod SoSecuirtyManagerDebugEnabled YES
sogod SxVMemLimit 512
sogod SoDebugObjectTraversal YES
sogod LDAPDebugEnabled YES
sogod SOGoMailMessageCheck every_5_minutes
sogod SOGoTimeZone America/Los_Angeles
sogod OCSEMailAlarmsFolderURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_email_alarms_folder [^]
sogod SOGoSentFolderName INBOX/Sent
sogod SOGoMailingMechanism smtp
sogod SOGoSMTPServer localhost
sogod OCSSessionsFolderURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_sessions_folder [^]
sogod SOGoIMAPServer localhost
sogod SOGoProfileURL postgresql://sogo:PASSWORD@p-sql:5432/sogo/sogo_user_profile [^]
sogod OCSFolderManagerSQLDebugEnabled YES
sogod SOGoEnableEMailAlarms YES
sogod SOGoCalendarDefaultRoles '(
PublicViewer,
ConfidentialDAndTViewer
)'
sogod WODebugZipRespons NO
sogod GCSFolderDebugEnabled YES
sogod domains '{
"site-1.com" = {
SOGoMailDomain = "site-1.com";
SOGoUserSources = (
{
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=authserv,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = PASSWORD;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = no;
passwordPolicy = NO;
port = 389;
type = ldap;
}
);
};
site2.net = {
SOGoMailDomain = site2.net;
SOGoUserSources = (
{
CNFieldName = cn;
IDFieldName = cn;
UIDFieldName = sAMAccountName;
baseDN = "cn=users,dc=other,dc=local";
bindDN = "cn=authserv,ou=systemusers,dc=other,dc=local";
bindFields = (
sAMAccountName
);
bindPassword = PASSWORD;
canAuthenticate = YES;
displayName = "Active Directory";
hostname = "dc";
id = directory;
isAddressBook = YES;
passwordPolicy = NO;
port = 389;
type = ldap;
}
);
};
}'
sogod SOGoACLsSendEMAILNotifications YES
sogod SOGoLanguage English
sogod OCSFolderInfoURL postgresql://sogo:Phies4ee@v-psql:5432/sogo/sogo_folder_info
sogod SOGoDebugRequests YES
sogod PGDebugEnabled YES
sogod SOGoUIxDebugEnabled YES
sogod SOGoAppointmentSendEMailNotifications YES
sogod SOGoFoldersSendEMAILNotifications YES
mjevans

mjevans

2011-03-10 01:18

reporter   ~0002242

I glanced at the source, looking over two of the LDAP files to see if I could figure out why behavior I just filed in a different bug happens. I think this is the first project I've seen using Objective C; is there an IDE of choice? I was glancing around to try tracking back the login process, but I think I got lost due to lack of familiarity with the project and Objective C in general.

I still plan to try finding the area where the config validation caused this error message and provide a patch that explains what was expected and not seen at a given location. I think that might be just simple enough to find and complete.
ludovic

ludovic

2011-04-11 20:30

administrator   ~0002370

There's no formal IDE but here, we pretty much all use Emacs.

Issue History

Date Modified Username Field Change
2011-03-09 00:03 mjevans New Issue
2011-03-09 00:15 ludovic Note Added: 0002231
2011-03-09 02:43 mjevans Note Added: 0002232
2011-03-09 13:37 ludovic Note Added: 0002234
2011-03-09 18:13 mjevans Note Added: 0002236
2011-03-10 01:18 mjevans Note Added: 0002242
2011-04-11 20:30 ludovic Note Added: 0002370
2011-04-11 20:30 ludovic Status new => resolved
2011-04-11 20:30 ludovic Resolution open => no change required
2011-04-11 20:30 ludovic Assigned To => ludovic