View Issue Details
| ID | Project | Category | View Status | Date Submitted | Last Update |
|---|---|---|---|---|---|
| 0003993 | SOGo | GUI | public | 2017-01-16 13:08 | 2017-01-31 19:56 |
| Reporter | zden2k | Assigned To | francis | ||
| Priority | urgent | Severity | minor | Reproducibility | have not tried |
| Status | resolved | Resolution | fixed | ||
| Platform | [Server] Linux | OS | Debian | OS Version | 8 (Jessie) |
| Product Version | 3.2.5 | ||||
| Fixed in Version | 3.2.7 | ||||
| Summary | 0003993: NSException after update | ||||
| Description | Hello, After update from v3.2.4 to v3.2.5 is sogo very unstable. Users who have subscribed shared calendars is unable to log on. Other users can. I ran gdb and sogo hangs on missing file. | ||||
| Tags | No tags attached. | ||||
|
sogo.log (25,575 bytes)
sogo@kalendar:~$
sogo@kalendar:~$ gdb --args /usr/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Debian 7.7.1+dfsg-5) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/sogod...Reading symbols from /usr/lib/debug//usr/sbin/sogod...done.
done.
(gdb)
(gdb)
(gdb)
(gdb) run
Starting program: /usr/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Jan 16 13:53:23 sogod [2318]: version 3.2.5 (build @shiva.inverse 201701160745) -- starting
Jan 16 13:53:23 sogod [2318]: vmem size check enabled: shutting down app when vmem > 384 MB. Currently at 181 MB
Jan 16 13:53:23 sogod [2318]: <0x0x555555a9fdf0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Jan 16 13:53:23 sogod [2318]: <0x0x555555a9fdf0[SOGoProductLoader]> Mailer.SOGo, Appointments.SOGo, MailPartViewers.SOGo, CommonUI.SOGo, PreferencesUI.SOGo, MailerUI.SOGo, SchedulerUI.SOGo, ActiveSync.SOGo, MainUI.SOGo, ContactsUI.SOGo, AdministrationUI.SOGo, Contacts.SOGo
Jan 16 13:53:24 sogod [2318]: All products loaded - current memory usage at 246 MB
2017-01-16 13:53:24.043 sogod[2318] PostgreSQL72 connection established: <0x0x5555558f05c0[PGConnection]: connection=0x0x555555c40f60>
2017-01-16 13:53:24.043 sogod[2318] PostgreSQL72 channel 0x0x555555b957a0 opened (connection=<0x0x5555558f05c0[PGConnection]: connection=0x0x555555c40f60>)
2017-01-16 13:53:24.043 sogod[2318] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_user_profile
2017-01-16 13:53:24.044 sogod[2318] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_folder_info
2017-01-16 13:53:24.046 sogod[2318] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_sessions_folder
2017-01-16 13:53:24.046 sogod[2318] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_alarms_folder
Jan 16 13:53:24 sogod [2318]: |SOGo| WOHttpAdaptor listening on address *:20000
Jan 16 13:53:34 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo'
Jan 16 13:53:34 sogod [2318]: <0x0x555555e19f40[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 16 13:53:34 sogod [2318]: <0x0x555555e19f40[SOGoCache]> Using host(s) '127.0.0.1' as server(s)
2017-01-16 13:53:34.123 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_defaults FROM sogo_user_profile WHERE c_uid = 'anonymous'
Jan 16 13:53:34 sogod [2318]: |SOGo| request took 0.054670 seconds to execute
Jan 16 13:53:34 sogod [2318]: 127.0.0.1 "GET /SOGo HTTP/1.0" 302 0/0 0.056 - - 2M
Jan 16 13:53:34 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo/'
Jan 16 13:53:34 sogod [2318]: |SOGo| constructed root-url: /SOGo/
Jan 16 13:53:34 sogod [2318]: |SOGo| setting root-url in context: /SOGo/
Jan 16 13:53:34 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/
Jan 16 13:53:34 sogod [2318]: |SOGo| request took 0.027695 seconds to execute
Jan 16 13:53:34 sogod [2318]: 127.0.0.1 "GET /SOGo/ HTTP/1.0" 200 21868/0 0.030 - - 1M
Jan 16 13:53:39 sogod [2318]: |SOGo| starting method 'POST' on uri '/SOGo/connect'
Jan 16 13:53:39 sogod [2318]: <0x0x555556077ef0[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
Jan 16 13:53:39 sogod [2318]: <0x0x555555e82950[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-16 13:53:39.807 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base '' filter '(objectClass=*)' for attrs 'subschemaSubentry'
2017-01-16 13:53:39.809 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'cn=Subschema' filter '(objectClass=*)' for attrs 'objectclasses'
2017-01-16 13:53:39.815 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=kalendar,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(objectClass=inetOrgPerson))' for attrs 'dn'
Jan 16 13:53:39 sogod [2318]: <0x0x555556077ef0[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
Jan 16 13:53:39 sogod [2318]: <0x0x555555e44000[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-16 13:53:39.829 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base '' filter '(objectClass=*)' for attrs 'subschemaSubentry'
2017-01-16 13:53:39.831 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'cn=Subschema' filter '(objectClass=*)' for attrs 'objectclasses'
2017-01-16 13:53:39.837 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=people,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(&(objectClass=posixAccount)(objectClass=inetOrgPerson)(mail=*)))' for attrs 'dn'
Jan 16 13:53:39 sogod [2318]: SOGoRootPage successful login from '127.0.0.1' for user 'htest' - expire = -1 grace = -1
Jan 16 13:53:39 sogod [2318]: <0x0x555555ff4280[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-16 13:53:39.866 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=kalendar,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(objectClass=inetOrgPerson))' for attrs '*'
Jan 16 13:53:39 sogod [2318]: <0x0x55555601a600[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-16 13:53:39.880 sogod[2318] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=people,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(&(objectClass=posixAccount)(objectClass=inetOrgPerson)(mail=*)))' for attrs '*'
2017-01-16 13:53:39.891 sogod[2318] PostgreSQL72 connection established: <0x0x555555fe3880[PGConnection]: connection=0x0x555555fe3a30>
2017-01-16 13:53:39.891 sogod[2318] PostgreSQL72 channel 0x0x555555fe31b0 opened (connection=<0x0x555555fe3880[PGConnection]: connection=0x0x555555fe3a30>)
2017-01-16 13:53:39.891 sogod[2318] PG0x0x555555fe31b0 SQL: BEGIN TRANSACTION
2017-01-16 13:53:39.891 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT t1.c_creationdate, t1.c_id, t1.c_lastseen, t1.c_value FROM sogo_sessions_folder t1 WHERE t1.c_id='L46bfP/ZVMhYnx4VyIswqw=='
2017-01-16 13:53:39.893 sogod[2318] PG0x0x555555fe31b0 SQL: ROLLBACK TRANSACTION
2017-01-16 13:53:39.893 sogod[2318] PG0x0x555555b957a0 SQL: BEGIN TRANSACTION
2017-01-16 13:53:39.893 sogod[2318] PG0x0x555555b957a0 SQL: INSERT INTO sogo_sessions_folder (c_lastseen, c_creationdate, c_value, c_id) VALUES (1484571219, 1484571219, 'aYGFoieGPcBNuzxFobswfPuzrHlftVxy94CT8itZwYLhs7M5OISDcfJ5FlBaHJuHY9D99vhpARYD5qGPEm5QNfIAwYUbdyXyHtkOOYaKFQfwjdY2xQthYVn5XwmrZ1VK4euxjpJkj1S2O9jJQmbNRp5ipRR/dr0t8QkT9pSnFlcEh5LdJasega/hYA2r4BSYufv1Hdfl+++leRjbLoB3DA==', 'L46bfP/ZVMhYnx4VyIswqw==')
2017-01-16 13:53:39.893 sogod[2318] PG0x0x555555b957a0 SQL: COMMIT TRANSACTION
Jan 16 13:53:39 sogod [2318]: [WARN] <0x0x5555561014f0[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 16 13:53:39 sogod [2318]: [WARN] <0x0x5555561014f0[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 16 13:53:39 sogod [2318]: [WARN] <0x0x5555561014f0[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
2017-01-16 13:53:39.910 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_settings FROM sogo_user_profile WHERE c_uid = 'htest'
Jan 16 13:53:39 sogod [2318]: |SOGo| request took 0.136758 seconds to execute
Jan 16 13:53:39 sogod [2318]: 127.0.0.1 "POST /SOGo/connect HTTP/1.0" 200 50/60 0.140 - - 992K
Jan 16 13:53:40 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo//htest'
Jan 16 13:53:40 sogod [2318]: |SOGo| request took 0.001177 seconds to execute
Jan 16 13:53:40 sogod [2318]: 127.0.0.1 "GET /SOGo//htest HTTP/1.0" 302 0/0 0.002 - - 0
Jan 16 13:53:40 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo//htest/view'
2017-01-16 13:53:40.966 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_defaults FROM sogo_user_profile WHERE c_uid = 'htest'
Jan 16 13:53:40 sogod [2318]: |SOGo| constructed root-url: /SOGo/
Jan 16 13:53:40 sogod [2318]: |SOGo| setting root-url in context: /SOGo/
Jan 16 13:53:40 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/
Jan 16 13:53:40 sogod [2318]: <0x555556098310[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo//htest/view
own: /SOGo/htest
Jan 16 13:53:40 sogod [2318]: |SOGo| request took 0.003981 seconds to execute
Jan 16 13:53:40 sogod [2318]: 127.0.0.1 "GET /SOGo//htest/view HTTP/1.0" 302 0/0 0.005 - - 4K
Jan 16 13:53:40 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo/so/htest/Calendar'
2017-01-16 13:53:40.981 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_path4 FROM sogo_folder_info WHERE c_path2 = 'htest' AND c_folder_type = 'Appointment'
2017-01-16 13:53:40.983 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'zasedacka 0p CZNIC' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-16 13:53:40.984 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_uid, c_object, c_role FROM sogozasedack00119af02df_acl WHERE (c_object = '/zasedacka 0p CZNIC/Calendar/personal') AND ((c_uid = 'htest') OR (c_uid LIKE '@%'))
2017-01-16 13:53:40.985 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_uid, c_object, c_role FROM sogozasedack00119af02df_acl WHERE (c_object = '/zasedacka 0p CZNIC/Calendar/personal') AND ((c_uid = '<default>') OR (c_uid LIKE '@%'))
Jan 16 13:53:40 sogod [2318]: |SOGo| request took 0.006236 seconds to execute
Jan 16 13:53:40 sogod [2318]: 127.0.0.1 "GET /SOGo/so/htest/Calendar HTTP/1.0" 302 0/0 0.007 - - 0
Jan 16 13:53:40 sogod [2318]: |SOGo| starting method 'GET' on uri '/SOGo/so/htest/Calendar/view'
2017-01-16 13:53:40.996 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_path4 FROM sogo_folder_info WHERE c_path2 = 'htest' AND c_folder_type = 'Appointment'
2017-01-16 13:53:41.028 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_foldername FROM sogo_folder_info WHERE c_path = '/Users/htest/Calendar/personal'
2017-01-16 13:53:41.029 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'htest' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-16 13:53:41.030 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_component, c_status FROM sogohtest001516b0a8a_quick WHERE ((c_component = 'vtodo') AND (c_status != 1) AND (c_status != 3))
Jan 16 13:53:41 sogod [2318]: |SOGo| constructed root-url: /SOGo/
Jan 16 13:53:41 sogod [2318]: |SOGo| setting root-url in context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560a3330[SOGoAppointmentFolder]:personal> baseURL: name=personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/personal
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560a3330[SOGoAppointmentFolder]:personal> baseURL: name=personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/personal
2017-01-16 13:53:41.032 sogod[2318] PG0x0x555555fe31b0 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'zasedacka 0p CZNIC' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-16 13:53:41.033 sogod[2318] PG0x0x555555b957a0 SQL: SELECT c_component, c_status FROM sogozasedack00119af02df_quick WHERE ((c_component = 'vtodo') AND (c_status != 1) AND (c_status != 3))
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560b28e0[SOGoAppointmentFolder]:zasedacka_SP_0p_SP_CZNIC_personal> baseURL: name=zasedacka_SP_0p_SP_CZNIC_personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/zasedacka_SP_0p_SP_CZNIC_personal
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560b28e0[SOGoAppointmentFolder]:zasedacka_SP_0p_SP_CZNIC_personal> baseURL: name=zasedacka_SP_0p_SP_CZNIC_personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/zasedacka_SP_0p_SP_CZNIC_personal
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560b28e0[SOGoAppointmentFolder]:zasedacka_SP_0p_SP_CZNIC_personal> baseURL: name=zasedacka_SP_0p_SP_CZNIC_personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/zasedacka_SP_0p_SP_CZNIC_personal
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: |SOGo| using root-url from context: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 16 13:53:41 sogod [2318]: <0x555555f64650[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 16 13:53:41 sogod [2318]: <0x5555560b3c40[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 16 13:53:41 sogod [2318]: <0x5555560b28e0[SOGoAppointmentFolder]:zasedacka_SP_0p_SP_CZNIC_personal> baseURL: name=zasedacka_SP_0p_SP_CZNIC_personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/zasedacka_SP_0p_SP_CZNIC_personal
EXCEPTION: <NSException: 0x5555561da850> NAME:NSRangeException REASON:Index 3 is out of range 0 (in 'insertObject:atIndex:') INFO:{Array = (); Count = 0; Index = 3; }
Program received signal SIGABRT, Aborted.
0x00007ffff448e067 in __GI_raise (sig=sig@entry=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:56
56 ../nptl/sysdeps/unix/sysv/linux/raise.c: No such file or directory.
(gdb) c
Continuing.
Program terminated with signal SIGABRT, Aborted.
The program no longer exists.
(gdb) q
sogo@kalendar:~$
|
|
|
When I reinstall back to older version from package sogo_3.2.4.20161214-1_amd64.deb, it's ok. Problem remains in both new packages: Please help me to investigate it. Thanks. |
|
|
Produce a stack trace: https://sogo.nu/nc/support/faq/article/how-do-i-debug-sogo.html |
|
|
sogobt.log (41,497 bytes)
sogo@kalendar:~$ gdb --args /usr/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Debian 7.7.1+dfsg-5) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/sogod...Reading symbols from /usr/lib/debug//usr/sbin/sogod...done.
done.
(gdb) run
Starting program: /usr/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Jan 18 19:51:44 sogod [23716]: version 3.2.5 (build @shiva.inverse 201701180746) -- starting
Jan 18 19:51:44 sogod [23716]: vmem size check enabled: shutting down app when vmem > 384 MB. Currently at 181 MB
Jan 18 19:51:44 sogod [23716]: <0x0x555555a9fdf0[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
Jan 18 19:51:44 sogod [23716]: <0x0x555555a9fdf0[SOGoProductLoader]> Mailer.SOGo, Appointments.SOGo, MailPartViewers.SOGo, CommonUI.SOGo, PreferencesUI.SOGo, MailerUI.SOGo, SchedulerUI.SOGo, ActiveSync.SOGo, MainUI.SOGo, ContactsUI.SOGo, AdministrationUI.SOGo, Contacts.SOGo
Jan 18 19:51:44 sogod [23716]: All products loaded - current memory usage at 246 MB
2017-01-18 19:51:44.902 sogod[23716] PostgreSQL72 connection established: <0x0x555555ccfa90[PGConnection]: connection=0x0x555555c40f60>
2017-01-18 19:51:44.902 sogod[23716] PostgreSQL72 channel 0x0x555555b957a0 opened (connection=<0x0x555555ccfa90[PGConnection]: connection=0x0x555555c40f60>)
2017-01-18 19:51:44.902 sogod[23716] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_user_profile
2017-01-18 19:51:44.903 sogod[23716] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_folder_info
2017-01-18 19:51:44.905 sogod[23716] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_sessions_folder
2017-01-18 19:51:44.905 sogod[23716] PG0x0x555555b957a0 SQL: SELECT count(*) FROM sogo_alarms_folder
Jan 18 19:51:44 sogod [23716]: |SOGo| WOHttpAdaptor listening on address *:20000
^C
Program received signal SIGINT, Interrupt.
0x00007ffff4538ad0 in __poll_nocancel () at ../sysdeps/unix/syscall-template.S:81
81 ../sysdeps/unix/syscall-template.S: No such file or directory.
(gdb) b [NSException raise]
Breakpoint 1 at 0x7ffff5388b40: file NSException.m, line 960.
(gdb) b abort
Breakpoint 2 at 0x7ffff448f300: abort. (2 locations)
(gdb) c
Continuing.
Jan 18 19:52:17 sogod [23716]: |SOGo| starting method 'GET' on uri '/SOGo'
Jan 18 19:52:17 sogod [23716]: <0x0x555555e28660[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 18 19:52:17 sogod [23716]: <0x0x555555e28660[SOGoCache]> Using host(s) '127.0.0.1' as server(s)
2017-01-18 19:52:17.272 sogod[23716] PG0x0x555555b957a0 SQL: BEGIN TRANSACTION
2017-01-18 19:52:17.273 sogod[23716] PG0x0x555555b957a0 SQL: SELECT t1.c_creationdate, t1.c_id, t1.c_lastseen, t1.c_value FROM sogo_sessions_folder t1 WHERE t1.c_id='LyfeoJwzYQ9hSckfCSJyIg=='
2017-01-18 19:52:17.274 sogod[23716] PG0x0x555555b957a0 SQL: ROLLBACK TRANSACTION
2017-01-18 19:52:17.282 sogod[23716] PostgreSQL72 connection established: <0x0x555555e663d0[PGConnection]: connection=0x0x555555e66580>
2017-01-18 19:52:17.282 sogod[23716] PostgreSQL72 channel 0x0x555555e65d00 opened (connection=<0x0x555555e663d0[PGConnection]: connection=0x0x555555e66580>)
2017-01-18 19:52:17.282 sogod[23716] PG0x0x555555e65d00 SQL: BEGIN TRANSACTION
2017-01-18 19:52:17.282 sogod[23716] PG0x0x555555e65d00 SQL: SELECT t1.c_creationdate, t1.c_id, t1.c_lastseen, t1.c_value FROM sogo_sessions_folder t1 WHERE t1.c_id='LyfeoJwzYQ9hSckfCSJyIg=='
2017-01-18 19:52:17.283 sogod[23716] PG0x0x555555e65d00 SQL: ROLLBACK TRANSACTION
2017-01-18 19:52:17.284 sogod[23716] PG0x0x555555b957a0 SQL: BEGIN TRANSACTION
2017-01-18 19:52:17.284 sogod[23716] PG0x0x555555b957a0 SQL: UPDATE sogo_sessions_folder SET c_lastseen = 1484765537, c_creationdate = 1484763740, c_value = 'UvvxyUwoRj3ej3nx8LX6n77qLvj1aSxPcYYN6Yq+CnEsgR+GGS4uoTWRi3dfGPPVcSAAB4nfsNqkfYyF1DcKqnNtLeMlD+gnECOiiGTdKe7MMkWtrmitQi1cr6vNWKj+2WUJfttWJhYabc2XmlKa57yTN1+1YaqVIzdP4upzS4HvSUmLzDk7vVbuAHNk+3gF4HnO9hiQ4kFLvDjSA7/y0w==', c_id = 'LyfeoJwzYQ9hSckfCSJyIg==' WHERE c_id='LyfeoJwzYQ9hSckfCSJyIg=='
2017-01-18 19:52:17.284 sogod[23716] PG0x0x555555b957a0 SQL: COMMIT TRANSACTION
Jan 18 19:52:17 sogod [23716]: <0x0x555555e8b300[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
Jan 18 19:52:17 sogod [23716]: <0x0x555555e8cca0[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-18 19:52:17.406 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base '' filter '(objectClass=*)' for attrs 'subschemaSubentry'
2017-01-18 19:52:17.412 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'cn=Subschema' filter '(objectClass=*)' for attrs 'objectclasses'
2017-01-18 19:52:17.426 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=kalendar,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(objectClass=inetOrgPerson))' for attrs 'dn'
Jan 18 19:52:17 sogod [23716]: <0x0x555555e8b300[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
Jan 18 19:52:17 sogod [23716]: <0x0x555555779420[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-18 19:52:17.466 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base '' filter '(objectClass=*)' for attrs 'subschemaSubentry'
2017-01-18 19:52:17.472 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'cn=Subschema' filter '(objectClass=*)' for attrs 'objectclasses'
2017-01-18 19:52:17.487 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=people,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(&(objectClass=posixAccount)(objectClass=inetOrgPerson)(mail=*)))' for attrs 'dn'
Jan 18 19:52:17 sogod [23716]: <0x0x555555fad710[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-18 19:52:17.564 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=kalendar,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(objectClass=inetOrgPerson))' for attrs '*'
Jan 18 19:52:17 sogod [23716]: <0x0x555555fc1b70[NGLdapConnection]> Using ldap_initialize for LDAP URL: ldaps://ldap.nic.cz:636
2017-01-18 19:52:17.606 sogod[23716] -[NGLdapConnection _searchAtBaseDN:qualifier:attributes:scope:]: search at base 'ou=people,dc=nic,dc=cz' filter '(&(|(uid=htest)(mail=htest)(userPassword=htest))(&(objectClass=posixAccount)(objectClass=inetOrgPerson)(mail=*)))' for attrs '*'
2017-01-18 19:52:17.613 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_defaults FROM sogo_user_profile WHERE c_uid = 'htest'
Jan 18 19:52:17 sogod [23716]: |SOGo| constructed root-url: /SOGo/
Jan 18 19:52:17 sogod [23716]: |SOGo| setting root-url in context: /SOGo/
Jan 18 19:52:17 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/
Jan 18 19:52:17 sogod [23716]: |SOGo| request took 0.581573 seconds to execute
Jan 18 19:52:17 sogod [23716]: 127.0.0.1 "GET /SOGo HTTP/1.0" 302 0/0 0.583 - - 5M
Jan 18 19:52:18 sogod [23716]: |SOGo| starting method 'GET' on uri '/SOGo/htest'
Jan 18 19:52:18 sogod [23716]: |SOGo| request took 0.001327 seconds to execute
Jan 18 19:52:18 sogod [23716]: 127.0.0.1 "GET /SOGo/htest HTTP/1.0" 302 0/0 0.002 - - 0
Jan 18 19:52:18 sogod [23716]: |SOGo| starting method 'GET' on uri '/SOGo/htest/view'
Jan 18 19:52:18 sogod [23716]: |SOGo| constructed root-url: /SOGo/
Jan 18 19:52:18 sogod [23716]: |SOGo| setting root-url in context: /SOGo/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/
Jan 18 19:52:18 sogod [23716]: <0x5555560988e0[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/htest/view
own: /SOGo/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| request took 0.002307 seconds to execute
Jan 18 19:52:18 sogod [23716]: 127.0.0.1 "GET /SOGo/htest/view HTTP/1.0" 302 0/0 0.003 - - 4K
Jan 18 19:52:18 sogod [23716]: |SOGo| starting method 'GET' on uri '/SOGo/so/htest/Calendar'
Jan 18 19:52:18 sogod [23716]: [WARN] <0x0x555555f68770[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 18 19:52:18 sogod [23716]: [WARN] <0x0x555555f68770[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 18 19:52:18 sogod [23716]: [WARN] <0x0x555555f68770[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
2017-01-18 19:52:18.057 sogod[23716] PG0x0x555555b957a0 SQL: SELECT c_path4 FROM sogo_folder_info WHERE c_path2 = 'htest' AND c_folder_type = 'Appointment'
2017-01-18 19:52:18.058 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_settings FROM sogo_user_profile WHERE c_uid = 'htest'
2017-01-18 19:52:18.059 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'zasedacka 0p CZNIC' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-18 19:52:18.060 sogod[23716] PG0x0x555555b957a0 SQL: SELECT c_uid, c_object, c_role FROM sogozasedack00119af02df_acl WHERE (c_object = '/zasedacka 0p CZNIC/Calendar/personal') AND ((c_uid = 'htest') OR (c_uid LIKE '@%'))
2017-01-18 19:52:18.061 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_uid, c_object, c_role FROM sogozasedack00119af02df_acl WHERE (c_object = '/zasedacka 0p CZNIC/Calendar/personal') AND ((c_uid = '<default>') OR (c_uid LIKE '@%'))
Jan 18 19:52:18 sogod [23716]: |SOGo| request took 0.007474 seconds to execute
Jan 18 19:52:18 sogod [23716]: 127.0.0.1 "GET /SOGo/so/htest/Calendar HTTP/1.0" 302 0/0 0.008 - - 0
Jan 18 19:52:18 sogod [23716]: |SOGo| starting method 'GET' on uri '/SOGo/so/htest/Calendar/view'
2017-01-18 19:52:18.077 sogod[23716] PG0x0x555555b957a0 SQL: SELECT c_path4 FROM sogo_folder_info WHERE c_path2 = 'htest' AND c_folder_type = 'Appointment'
2017-01-18 19:52:18.111 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_foldername FROM sogo_folder_info WHERE c_path = '/Users/htest/Calendar/personal'
2017-01-18 19:52:18.112 sogod[23716] PG0x0x555555b957a0 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'htest' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-18 19:52:18.113 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_component, c_status FROM sogohtest001516b0a8a_quick WHERE ((c_component = 'vtodo') AND (c_status != 1) AND (c_status != 3))
Jan 18 19:52:18 sogod [23716]: |SOGo| constructed root-url: /SOGo/
Jan 18 19:52:18 sogod [23716]: |SOGo| setting root-url in context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: <0x555555f6bbb0[SOGoAppointmentFolder]:personal> baseURL: name=personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/personal
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: <0x555555f6bbb0[SOGoAppointmentFolder]:personal> baseURL: name=personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/personal
2017-01-18 19:52:18.117 sogod[23716] PG0x0x555555b957a0 SQL: SELECT c_folder_id, c_path, c_location, c_quick_location, c_acl_location, c_folder_type FROM sogo_folder_info WHERE c_path1 = 'Users' AND c_path2 = 'zasedacka 0p CZNIC' AND c_path3 = 'Calendar' AND c_path4 = 'personal'
2017-01-18 19:52:18.118 sogod[23716] PG0x0x555555e65d00 SQL: SELECT c_component, c_status FROM sogozasedack00119af02df_quick WHERE ((c_component = 'vtodo') AND (c_status != 1) AND (c_status != 3))
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: |SOGo| using root-url from context: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: |SOGo| ROOT baseURL(no container, name=(null)):
own: /SOGo/so/
Jan 18 19:52:18 sogod [23716]: <0x555555f72840[SOGoUserFolder]:htest> baseURL: name=htest (container=SOGo)
container: /SOGo -- https://kalendar.test.nic.cz/SOGo/so/htest/Calendar/view
own: /SOGo/so/htest
Jan 18 19:52:18 sogod [23716]: <0x555555ef6bc0[SOGoAppointmentFolders]:Calendar> baseURL: name=Calendar (container=SOGoUserFolder)
container: /SOGo/so/htest/
own: /SOGo/so/htest/Calendar
Jan 18 19:52:18 sogod [23716]: <0x555555f7dbb0[SOGoAppointmentFolder]:zasedacka_SP_0p_SP_CZNIC_personal> baseURL: name=zasedacka_SP_0p_SP_CZNIC_personal (container=SOGoAppointmentFolders)
container: /SOGo/so/htest/Calendar/
own: /SOGo/so/htest/Calendar/zasedacka_SP_0p_SP_CZNIC_personal
Breakpoint 1, -[NSException raise] (self=0x555556190dc0, _cmd=0x7ffff5871fc0 <_OBJC_SELECTOR_TABLE+384>) at NSException.m:960
960 NSException.m: No such file or directory.
(gdb) bt full
#0 -[NSException raise] (self=0x555556190dc0, _cmd=0x7ffff5871fc0 <_OBJC_SELECTOR_TABLE+384>) at NSException.m:960
No locals.
#1 0x00007ffff53887a3 in +[NSException raise:format:] (self=self@entry=0x7ffff58722c0 <_OBJC_Class_NSException>, _cmd=_cmd@entry=0x7ffff58d95b0 <_OBJC_SELECTOR_TABLE+304>, name=0x7ffff5872950 <_OBJC_INSTANCE_4>,
format=format@entry=0x7ffff58da870 <_OBJC_INSTANCE_27>) at NSException.m:840
args = {{gp_offset = 32, fp_offset = 48, overflow_arg_area = 0x7fffffffaf30, reg_save_area = 0x7fffffffae60}}
#2 0x00007ffff545699c in -[NSURL initWithString:relativeToURL:] (self=0x555556190930, _cmd=<optimized out>, aUrlString=<optimized out>, aBaseUrl=<optimized out>) at NSURL.m:1247
buf = <optimized out>
size = <optimized out>
end = <optimized out>
usesQueries = <optimized out>
ptr = <optimized out>
usesParameters = <optimized out>
canBeGeneric = <optimized out>
base = <optimized out>
start = <optimized out>
usesFragments = <optimized out>
filepath = <synthetic pointer>
#3 0x00007ffff5454c78 in +[NSURL URLWithString:relativeToURL:] (self=<optimized out>, _cmd=<optimized out>, aUrlString=0x55555618c220, aBaseUrl=0x555556190570) at NSURL.m:646
No locals.
#4 0x00007ffff7b203f6 in -[SOGoGCSFolder realDavURL] (self=0x555555f7dbb0, _cmd=0x7fffec92d0d0 <_OBJC_SELECTOR_TABLE+4496>) at SOGoGCSFolder.m:502
realDavURL = 0x0
currentDavURL = 0x555556190570
appName = 0x5555560d42f0
publicParticle = 0x7ffff7da00a0 <_OBJC_INSTANCE_39>
path = 0x55555618c220
#5 0x00007fffec6f3f26 in -[SOGoAppointmentFolder _baseCalDAVURL] (self=0x555555f7dbb0, _cmd=0x7fffec92d100 <_OBJC_SELECTOR_TABLE+4544>) at SOGoAppointmentFolder.m:2877
davURL = 0x555555f7dbb0
#6 0x00007fffec6f429b in -[SOGoAppointmentFolder webDavXMLURL] (self=0x555555f7dbb0, _cmd=0x7fffe99ac8f0 <_OBJC_SELECTOR_TABLE+880>) at SOGoAppointmentFolder.m:2917
No locals.
#7 0x00007fffe9786df2 in -[UIxCalendarSelector calendars] (self=0x555556150dd0, _cmd=0x555556149590) at UIxCalendarSelector.m:228
objectCreator = 0 '\000'
objectEraser = 0 '\000'
reloadOnLogin = 0 '\000'
synchronize = 0 '\000'
dirty = 0 '\000'
folders = 0x55555614b320
allACLs = 0x55555618a8d0
sortedFolders = 0x55555614b090
sortedFolderNames = 0x55555614b050
moduleSettings = 0x555555e0d470
calendar = 0x5555561751f0
notifications = 0x5555561750e0
urls = 0x555556170b10
acls = 0x55555618bf50
isActive = 0x5555558f4840
fActiveTasks = 0x5555558f8bd0
userLogin = 0x555555f80c00
folderName = 0x555555f799c0
fDisplayName = 0x555555f6de60
owner = 0x555555770cb0
count = 1
index = 1
max = 2
folder = 0x555555f7dbb0
co = 0x555555ef6bc0
activeUser = 0x555555f0bc40
us = 0x555555f5de30
#8 0x00007ffff6c54888 in _getComponentValue (self=0x55555610e080, object=0x555556150dd0, info=0x555556150910) at WOKeyPathAssociation.m:537
retValue = {object = 0x555555b53d70, cstr = 0x555555b53d70 "@\232\203\365\377\177", sint = 1437941104, uint = 1437941104, longt = 93824998522224, ulongt = 93824998522224, llong = 93824998522224, ullong = 93824998522224,
ss = 15728, us = 15728, c = 112 'p', flt = 2.49094346e+13, dbl = 4.6355708490936603e-310}
__PRETTY_FUNCTION__ = "_getComponentValue"
#9 0x00007ffff6c55107 in _getValueN (self=0x55555610e080, _count=2, root=0x555556150dd0) at WOKeyPathAssociation.m:737
info = 0x555556150910
retValue = {object = 0x7fffffffb300, cstr = 0x7fffffffb300 "\320\r\025VUU", sint = -19712, uint = 4294947584, longt = 140737488335616, ulongt = 140737488335616, llong = 140737488335616, ullong = 140737488335616, ss = -19712,
us = 45824, c = 0 '\000', flt = -nan(0x7fb300), dbl = 6.9533558068611021e-310}
cnt = 0
---Type <return> to continue, or q <return> to quit---
object = 0x555556150dd0
__PRETTY_FUNCTION__ = "_getValueN"
#10 0x00007ffff6c55190 in _getValue (self=0x55555610e080, root=0x555556150dd0) at WOKeyPathAssociation.m:750
No locals.
#11 0x00007ffff6c55ea2 in -[WOKeyPathAssociation valueInComponent:] (self=0x55555610e080, _cmd=0x7ffff6f8bf80 <_OBJC_SELECTOR_TABLE+448>, _component=0x555556150dd0) at WOKeyPathAssociation.m:1004
result = 0x555555e19160
#12 0x00007ffff6c519ce in -[WOAssociation valueInContext:] (self=0x55555610e080, _cmd=0x7ffff6fc91a0 <_OBJC_SELECTOR_TABLE+928>, _ctx=0x555555e19160) at WOAssociation.m:223
No locals.
#13 0x00007ffff6c90913 in -[_WOComplexString appendToResponse:inContext:] (self=0x555556155330, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOString.m:561
sComponent = 0x555556150dd0
fmt = 0x0
obj = 0x0
addSel = 0x0
styleName = 0x555555e36750
#14 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x5555561554e0, _cmd=0x7ffff6fbd230 <_OBJC_SELECTOR_TABLE+304>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555556155330
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 1
depth = 8
st = 0
#15 0x00007ffff6c7c765 in -[WOGenericContainer appendToResponse:inContext:] (self=0x555556150d60, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOGenericContainer.m:121
sComponent = 0x555556150dd0
tag = 0x0
#16 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x555556154d10, _cmd=0x7ffff6f99160 <_OBJC_SELECTOR_TABLE+352>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555556150d60
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 1
depth = 8
st = 0
#17 0x00007ffff6c63661 in -[WOTemplate appendToResponse:inContext:] (self=0x5555561555b0, _cmd=0x7ffff6f405c0 <_OBJC_SELECTOR_TABLE+1984>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOTemplate.m:119
No locals.
#18 0x00007ffff6c01258 in -[WOComponent appendToResponse:inContext:] (self=0x555556150dd0, _cmd=0x7ffff6f5f990 <_OBJC_SELECTOR_TABLE+528>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOComponent.m:928
template = 0x5555561555b0
st = 0
__PRETTY_FUNCTION__ = "-[WOComponent appendToResponse:inContext:]"
#19 0x00007ffff6c26d35 in -[WOChildComponentReference appendToResponse:inContext:] (self=0x555555f6e570, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOChildComponentReference.m:181
parent = 0x555555fb9df0
child = 0x555556150dd0
st = 0
__PRETTY_FUNCTION__ = "-[WOChildComponentReference appendToResponse:inContext:]"
#20 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x5555561322a0, _cmd=0x7ffff6fb7ec0 <_OBJC_SELECTOR_TABLE+448>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555555f6e570
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 3
depth = 8
st = 0
#21 0x00007ffff6c73a19 in -[WOComponentContent appendToResponse:inContext:] (self=0x555555eff720, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOComponentContent.m:149
st = 0
component = 0x5555560572e0
content = 0x5555561322a0
#22 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x555555ebcec0, _cmd=0x7ffff6fb9860 <_OBJC_SELECTOR_TABLE+736>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555555eff720
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 6
depth = 8
st = 0
#23 0x00007ffff6c7656f in -[WOConditional appendToResponse:inContext:] (self=0x555556124820, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOConditional.m:242
No locals.
---Type <return> to continue, or q <return> to quit---
#24 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x555555fc3460, _cmd=0x7ffff6fb5f70 <_OBJC_SELECTOR_TABLE+304>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555556124820
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 3
depth = 8
st = 0
#25 0x00007ffff6c6f89a in -[WOBody appendToResponse:inContext:] (self=0x555555f3e020, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOBody.m:157
uUri = 0x0
uFi = 0x0
#26 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x555555edfa60, _cmd=0x7ffff6fbd230 <_OBJC_SELECTOR_TABLE+304>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555555f3e020
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 3
depth = 8
st = 0
#27 0x00007ffff6c7c765 in -[WOGenericContainer appendToResponse:inContext:] (self=0x555555f06ed0, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOGenericContainer.m:121
sComponent = 0x5555560572e0
tag = 0x0
#28 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x555555ed4a90, _cmd=0x7ffff6fb9860 <_OBJC_SELECTOR_TABLE+736>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555555f06ed0
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 1
depth = 8
st = 0
#29 0x00007ffff6c7656f in -[WOConditional appendToResponse:inContext:] (self=0x555555f47cf0, _cmd=0x7ffff6fb8f10 <_OBJC_SELECTOR_TABLE+720>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOConditional.m:242
No locals.
#30 0x00007ffff6c754b8 in -[WOCompoundElement appendToResponse:inContext:] (self=0x55555611dd80, _cmd=0x7ffff6f99160 <_OBJC_SELECTOR_TABLE+352>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOCompoundElement.m:247
child = 0x555555f47cf0
pool = 0x0
st = 0
incId = 0x7ffff6c07f76 <-[WOContext incrementLastElementIDComponent]>
i = 3
depth = 8
st = 0
#31 0x00007ffff6c63661 in -[WOTemplate appendToResponse:inContext:] (self=0x555555f53510, _cmd=0x7ffff6f405c0 <_OBJC_SELECTOR_TABLE+1984>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOTemplate.m:119
No locals.
#32 0x00007ffff6c01258 in -[WOComponent appendToResponse:inContext:] (self=0x5555560572e0, _cmd=0x7ffff6f5f990 <_OBJC_SELECTOR_TABLE+528>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOComponent.m:928
template = 0x555555f53510
st = 0
__PRETTY_FUNCTION__ = "-[WOComponent appendToResponse:inContext:]"
#33 0x00007ffff6c26d35 in -[WOChildComponentReference appendToResponse:inContext:] (self=0x555556132240, _cmd=0x7ffff6f99160 <_OBJC_SELECTOR_TABLE+352>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOChildComponentReference.m:181
parent = 0x555555fb9df0
child = 0x5555560572e0
st = 0
__PRETTY_FUNCTION__ = "-[WOChildComponentReference appendToResponse:inContext:]"
#34 0x00007ffff6c63661 in -[WOTemplate appendToResponse:inContext:] (self=0x555556131080, _cmd=0x7ffff6f405c0 <_OBJC_SELECTOR_TABLE+1984>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOTemplate.m:119
No locals.
#35 0x00007ffff6c01258 in -[WOComponent appendToResponse:inContext:] (self=0x555555fb9df0, _cmd=0x7ffff6fe9f00 <_OBJC_SELECTOR_TABLE+448>, _response=0x555555f064d0, _ctx=0x555555e19160) at WOComponent.m:928
template = 0x555556131080
st = 0
__PRETTY_FUNCTION__ = "-[WOComponent appendToResponse:inContext:]"
#36 0x00007ffff6cab0a8 in -[SoDefaultRenderer renderComponent:inContext:] (self=0x5555560079a0, _cmd=0x7ffff6fea040 <_OBJC_SELECTOR_TABLE+768>, _c=0x555555fb9df0, _ctx=0x555555e19160) at SoDefaultRenderer.m:139
r = 0x555555f064d0
#37 0x00007ffff6cabc19 in -[SoDefaultRenderer renderObject:inContext:] (self=0x5555560079a0, _cmd=0x7ffff6feeaa0 <_OBJC_SELECTOR_TABLE+1248>, _object=0x555555fb9df0, _ctx=0x555555e19160) at SoDefaultRenderer.m:258
sm = 0x555555be3430
e = 0x0
#38 0x00007ffff6cb340a in -[SoObjectRequestHandler renderObject:inContext:] (self=0x555555b384c0, _cmd=0x7ffff6feebf0 <_OBJC_SELECTOR_TABLE+1584>, _object=0x555555fb9df0, _ctx=0x555555e19160) at SoObjectRequestHandler.m:466
renderer = 0x5555560079a0
error = 0x7ffff53dc8c0 <-[NSObject isKindOfClass:]>
e = 0x555555f52d50
---Type <return> to continue, or q <return> to quit---
container = 0x0
#39 0x00007ffff6cb4148 in -[SoObjectRequestHandler handleRequest:inContext:session:application:] (self=0x555555b384c0, _cmd=0x7ffff6f730d0 <_OBJC_SELECTOR_TABLE+848>, _rq=0x5555560bc450, _ctx=0x555555e19160, _sn=0x0, app=0x555555b1ba50)
at SoObjectRequestHandler.m:616
r = 0x0
object = 0x555555fb9df0
authenticator = 0x555555e21480
doDispatch = 1 '\001'
#40 0x00007ffff6c3b565 in -[WORequestHandler handleRequest:] (self=0x555555b384c0, _cmd=0x7ffff6f3cd90 <_OBJC_SELECTOR_TABLE+1616>, _request=0x5555560bc450) at WORequestHandler.m:237
startHandling = 0
app = 0x555555b1ba50
response = 0x0
context = 0x555555e19160
thread = 0x555555895540
sessionId = 0x0
session = 0x0
uri = 0x555555eb0900
#41 0x00007ffff6bfc8ac in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555b1ba50, _cmd=0x7ffff6f3cde0 <_OBJC_SELECTOR_TABLE+1696>, _request=0x5555560bc450, handler=0x555555b384c0) at WOCoreApplication.m:712
startDispatch = 0
response = 0x0
startDispatch = 0
#42 0x00007ffff6bfcbd3 in -[WOCoreApplication dispatchRequest:] (self=0x555555b1ba50, _cmd=0x555555763ef0 <_OBJC_SELECTOR_TABLE+1648>, _request=0x5555560bc450) at WOCoreApplication.m:752
handler = 0x555555b384c0
#43 0x000055555555caa6 in -[SOGo dispatchRequest:] (self=0x555555b1ba50, _cmd=0x7ffff6fd72e0 <_OBJC_SELECTOR_TABLE+1760>, _request=0x5555560bc450) at SOGo.m:572
runLoopModes = 0x555556028320
debugOn = 0 '\000'
sd = 0x555555a43750
resp = 0x7ffff62f80f6 <-[NGBufferedStream initWithSource:]+70>
startDate = 0x555556077520
path = 0x5555560c23b0
timeDelta = 6.9533558070618904e-310
objc_super = {self = 0x555555b1ba50, super_class = 0x7ffff6fe7240 <_OBJC_Class_SoApplication>}
#44 0x00007ffff6ca295a in -[WOHttpTransaction _run] (self=0x555555f72dd0, _cmd=0x7ffff6fd7310 <_OBJC_SELECTOR_TABLE+1808>) at WOHttpTransaction.m:566
No locals.
#45 0x00007ffff6ca2cd0 in -[WOHttpTransaction run] (self=0x555555f72dd0, _cmd=0x7ffff6fd5050 <_OBJC_SELECTOR_TABLE+1168>) at WOHttpTransaction.m:619
ok = 1 '\001'
#46 0x00007ffff6c9ea3d in -[WOHttpAdaptor runConnection:] (self=0x555555dec190, _cmd=0x7ffff6fd50f0 <_OBJC_SELECTOR_TABLE+1328>, _socket=0x5555560b87f0) at WOHttpAdaptor.m:373
tx = 0x555555f72dd0
#47 0x00007ffff6c9ec5d in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555dec190, _cmd=0x7ffff6fd5100 <_OBJC_SELECTOR_TABLE+1344>, _connection=0x5555560b87f0) at WOHttpAdaptor.m:407
t = 4.6355711284960833e-310
#48 0x00007ffff6c9f068 in -[WOHttpAdaptor _handleConnection:] (self=0x555555dec190, _cmd=0x7ffff6fd51a0 <_OBJC_SELECTOR_TABLE+1504>, connection=0x5555560b87f0) at WOHttpAdaptor.m:466
No locals.
#49 0x00007ffff6c9f4e2 in -[WOHttpAdaptor acceptConnection:] (self=0x555555dec190, _cmd=0x7ffff6fd5010 <_OBJC_SELECTOR_TABLE+1104>, _notification=0x555555f5bb30) at WOHttpAdaptor.m:527
No locals.
#50 0x00007ffff53cbd07 in -[NSNotificationCenter _postAndRelease:] (self=0x555555899a90, _cmd=<optimized out>, notification=0x555555f5bb30) at NSNotificationCenter.m:1307
o = 0x55555589c6b8
count = 0
name = <optimized out>
object = 0x555555df56b0
n = <optimized out>
m = <optimized out>
i = {{addr = 93824995673784, ext = 0x55555589c6b8}, {addr = 2090623100, ext = 0x7c9c607c}, {addr = 19, ext = 0x13}, {addr = 85, ext = 0x55}, {addr = 93824999438512, ext = 0x555555c338b0}, {addr = 140737351931278,
ext = 0x7ffff7de558e <do_lookup_x+2334>}, {addr = 140737488340608, ext = 0x7fffffffc680}, {addr = 140737488340416, ext = 0x7fffffffc5c0}, {addr = 140737291603240, ext = 0x7ffff445cd28}, {addr = 140737291626808,
ext = 0x7ffff4462938}, {addr = 140737488340688, ext = 0x7fffffffc6d0}, {addr = 32665985, ext = 0x1f27181}, {addr = 140737488340672, ext = 0x7fffffffc6c0}, {addr = 140737488340608, ext = 0x7fffffffc680}, {addr = 0,
ext = 0x0}, {addr = 140737353987656, ext = 0x7ffff7fdb648}, {addr = 140737354044648, ext = 0x7ffff7fe94e8}, {addr = 140737305302314, ext = 0x7ffff516d52a}, {addr = 140737291656568, ext = 0x7ffff4469d78}, {
addr = 140737305224368, ext = 0x7ffff515a4b0}, {addr = 4294967296, ext = 0x100000000}, {addr = 4294968278, ext = 0x1000003d6}, {addr = 140737488348900, ext = 0x7fffffffe6e4}, {addr = 140737353987656, ext = 0x7ffff7fdb648}, {
addr = 140737488340832, ext = 0x7fffffffc760}, {addr = 140737354054944, ext = 0x7ffff7febd20}, {addr = 140737488340872, ext = 0x7fffffffc788}, {addr = 140737354054088, ext = 0x7ffff7feb9c8}, {addr = 1, ext = 0x1}, {
addr = 140737351931709, ext = 0x7ffff7de573d <_dl_lookup_symbol_x+349>}, {addr = 0, ext = 0x0}, {addr = 140737353987656, ext = 0x7ffff7fdb648}, {addr = 1, ext = 0x1}, {addr = 140737306915747,
ext = 0x7ffff52f73a3 <-[NSConstantString hash]+979>}, {addr = 1, ext = 0x1}, {addr = 140737306915747, ext = 0x7ffff52f73a3 <-[NSConstantString hash]+979>}, {addr = 511101108334, ext = 0x770000006e}, {addr = 0, ext = 0x0}, {
addr = 2320761389137788928, ext = 0x2035003000000000}, {addr = 3689111531693764467, ext = 0x33325b646f676f73}, {addr = 0, ext = 0x0}, {addr = 140737295410720, ext = 0x7ffff47fe620 <main_arena>}, {addr = 48, ext = 0x30}, {
addr = 48, ext = 0x30}, {addr = 0, ext = 0x0}, {addr = 140737312809408, ext = 0x7ffff58961c0 <_OBJC_Class_GSNotification>}, {addr = 93825002748720, ext = 0x555555f5bb30}, {addr = 93825001281200, ext = 0x555555df56b0}, {
addr = 140737323413312, ext = 0x7ffff62b2f40 <_OBJC_INSTANCE_0>}, {addr = 140737307850766, ext = 0x7ffff53db80e <callCXXConstructors+30>}, {addr = 140737312809408, ext = 0x7ffff58961c0 <_OBJC_Class_GSNotification>}, {
addr = 93825002748720, ext = 0x555555f5bb30}, {addr = 140737312809408, ext = 0x7ffff58961c0 <_OBJC_Class_GSNotification>}, {addr = 48, ext = 0x30}, {addr = 93825001281200, ext = 0x555555df56b0}, {addr = 140737307858704,
ext = 0x7ffff53dd710 <NSAllocateObject+144>}, {addr = 140737295410720, ext = 0x7ffff47fe620 <main_arena>}, {addr = 93825001302112, ext = 0x555555dfa860}, {addr = 93825001302096, ext = 0x555555dfa850}, {
addr = 93824995662480, ext = 0x555555899a90}, {addr = 93825002748720, ext = 0x555555f5bb30}, {addr = 0, ext = 0x0}, {addr = 93825001281200, ext = 0x555555df56b0}, {addr = 140737323413312,
ext = 0x7ffff62b2f40 <_OBJC_INSTANCE_0>}}
b = {ptr = 0x7fffffffc550, count = 1, cap = <optimized out>, old = 0, zone = 0x7ffff58f8840 <default_zone>}
---Type <return> to continue, or q <return> to quit---
a = <synthetic pointer>
#51 0x00007ffff6068812 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555df56b0, _cmd=0x7ffff592d430 <_OBJC_SELECTOR_TABLE+304>, _fdData=0x7, _type=ET_RDESC, _extra=0x7,
_mode=0x7ffff58bc770 <_OBJC_INSTANCE_2>) at NSRunLoop+FileObjects.m:58
nc = 0x555555899a90
#52 0x00007ffff54d6b3b in -[GSRunLoopCtxt pollUntil:within:] (self=<optimized out>, _cmd=0x7ffff58bb900 <_OBJC_SELECTOR_TABLE+1216>, milliseconds=<optimized out>, contexts=<optimized out>) at GSRunLoopCtxt.m:642
fd = <optimized out>
watcher = 0x555555df8ef0
found = <optimized out>
threadInfo = 0x555555b8eae0
poll_return = 1
fdEnd = 2
fdIndex = <optimized out>
fdFinish = 1
count = <optimized out>
i = <optimized out>
immediate = <optimized out>
#53 0x00007ffff5414840 in -[NSRunLoop acceptInputForMode:beforeDate:] (self=0x555555bc2e90, _cmd=0x7ffff5871fc0 <_OBJC_SELECTOR_TABLE+384>, mode=0x7ffff58bc770 <_OBJC_INSTANCE_2>, limit_date=0x555555b8f380) at NSRunLoop.m:1217
context = 0x555555b80980
ti = 0
savedMode = 0x0
arp = 0x555555dfa6f0
#54 0x00007ffff5414cf2 in -[NSRunLoop runMode:beforeDate:] (self=0x555555bc2e90, _cmd=0x555555b80980, mode=0x7ffff58bc770 <_OBJC_INSTANCE_2>, date=0x555555bee040) at NSRunLoop.m:1288
arp = 0x555555df8f70
savedMode = 0x555555bee040
context = 0x555555b80980
d = 0x555555bee040
#55 0x00007ffff6bfc0e2 in -[WOCoreApplication run] (self=0x555555b1ba50, _cmd=0x555555763c40 <_OBJC_SELECTOR_TABLE+960>) at WOCoreApplication.m:584
loop = 0x555555bc2e90
limitDate = 0x555555bee040
pool = 0x555555cfee10
#56 0x000055555555bcd0 in -[SOGo run] (self=0x555555b1ba50, _cmd=0x7ffff6f5ed50 <_OBJC_SELECTOR_TABLE+208>) at SOGo.m:329
objc_super = {self = 0x555555b1ba50, super_class = 0x7ffff6fe7240 <_OBJC_Class_SoApplication>}
#57 0x00007ffff6c26169 in WOApplicationMain (_appClassName=0x555555761c00 <_OBJC_INSTANCE_0>, argc=13, argv=0x7fffffffec38) at WOApplicationMain.m:42
app = 0x555555b1ba50
pool = 0x555555a9fae0
#58 0x00007ffff6c46a87 in WOWatchDogApplicationMain (appName=0x555555761c00 <_OBJC_INSTANCE_0>, argc=13, argv=0x7fffffffec38) at WOWatchDogApplicationMain.m:1049
pool = 0x555555901bf0
ud = 0x5555558fd400
logFile = 0x55555593a0e0
nsPidFile = 0x55555593a290
rc = 21845
childPid = 0
processInfo = 0x55555591aae0
WOAppClass = 0x555555763800 <_OBJC_Class_SOGo>
#59 0x000055555555a9e9 in main (argc=13, argv=0x7fffffffec38, env=0x7fffffffeca8) at sogod.m:51
pool = 0x5555558d4400
sd = 0x555555a43750
rc = 0
(gdb)
(gdb)
|
|
|
(gdb) bt |
|
|
What that happens, do: f 4 Show the output. |
|
|
note: my test user "htest" have only one subscribed shared calendar for tests. sogo@kalendar:~$ gdb --args /usr/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid Breakpoint 1, -[NSException raise] (self=0x5555561b8d50, _cmd=0x7ffff5871fc0 <_OBJC_SELECTOR_TABLE+384>) at NSException.m:960 Breakpoint 1, -[NSException raise] (self=0x5555561bcba0, _cmd=0x7ffff5871fc0 <_OBJC_SELECTOR_TABLE+384>) at NSException.m:960
Quit anyway? (y or n) y |
|
|
Maybe it could have some association with ticket 0003931 ? |
|
|
Hello, any progress in this ticket? Can I do something else? |
|
|
When that happens, in gdb do: f 3 |
|
|
(gdb) f 3 |
|
|
Please try the latest nightly build. |
|
|
Hello, seems working again. Thanks for fix. :-) |
|
| Date Modified | Username | Field | Change |
|---|---|---|---|
| 2017-01-16 13:08 | zden2k | New Issue | |
| 2017-01-16 13:08 | zden2k | File Added: sogo.log | |
| 2017-01-18 18:32 | zden2k | Note Added: 0011224 | |
| 2017-01-18 18:34 | ludovic | Note Added: 0011225 | |
| 2017-01-18 19:06 | zden2k | File Added: sogobt.log | |
| 2017-01-18 19:25 | zden2k | Note Added: 0011226 | |
| 2017-01-18 20:22 | ludovic | Note Added: 0011227 | |
| 2017-01-18 20:22 | ludovic | Note Edited: 0011227 | |
| 2017-01-18 20:56 | ludovic | Severity | crash => minor |
| 2017-01-19 08:35 | zden2k | Note Added: 0011229 | |
| 2017-01-20 10:37 | zden2k | Note Added: 0011234 | |
| 2017-01-30 10:12 | zden2k | Note Added: 0011247 | |
| 2017-01-30 23:20 | ludovic | Note Added: 0011250 | |
| 2017-01-31 02:57 | francis | Changeset attached | => sogo master 539a6c3b |
| 2017-01-31 02:57 | francis | Assigned To | => francis |
| 2017-01-31 02:57 | francis | Resolution | open => fixed |
| 2017-01-31 02:57 | francis | Status | new => resolved |
| 2017-01-31 02:57 | francis | Fixed in Version | => 3.2.7 |
| 2017-01-31 19:46 | zden2k | Note Added: 0011252 | |
| 2017-01-31 19:46 | zden2k | Status | resolved => feedback |
| 2017-01-31 19:46 | zden2k | Resolution | fixed => reopened |
| 2017-01-31 19:47 | francis | Note Added: 0011253 | |
| 2017-01-31 19:56 | zden2k | Note Added: 0011254 | |
| 2017-01-31 19:56 | zden2k | Status | feedback => assigned |
| 2017-01-31 19:56 | francis | Status | assigned => resolved |
| 2017-01-31 19:56 | francis | Resolution | reopened => fixed |