View Issue Details
| ID | Project | Category | View Status | Date Submitted | Last Update |
|---|---|---|---|---|---|
| 0004767 | SOGo | Web Mail | public | 2019-06-17 07:56 | 2019-07-18 06:20 |
| Reporter | ondrej.kolin | Assigned To | |||
| Priority | normal | Severity | minor | Reproducibility | have not tried |
| Status | new | Resolution | open | ||
| Platform | Server | OS | Ubuntu | OS Version | 18.04 |
| Product Version | 4.0.7 | ||||
| Summary | 0004767: Profile corruption | ||||
| Description | User's profile gets corrupted, so its not anymore parsable by JSON. I have an assumption, that this happens after IMAP connection gets broken. Appending log. This happend twice so far in one week | ||||
| Steps To Reproduce | No real steps to reproduce. It just occures at some point | ||||
| Tags | No tags attached. | ||||
 |
sogo_error.txt (25,136 bytes)
Jun 17 09:18:53 sogod [5454]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/0/folderINBOX/view HTTP/1.1" 200 10071/45 1.008 - - -16K
Jun 17 09:18:55 sogod [5454]: [ERROR] <0x0x564517b9ca60[NGImap4ConnectionManager]> IMAP4 login failed:
host=mail.company.com, user=username, pwd=yes
url=imaps://username@mail.company.com/?tls=YES
base=(null)
base-class=(null))
= <0x0x5645211f4580[NGImap4Client]: login=username(pwd) address=<0x0x5645211d3490[NGInternetSocketAddress]: host=mail.company.com not-filled>>
Jun 17 09:18:55 sogod [5454]: <0x564527705ee0[SOGoMailAccount]:0> renewing imap4 password
Jun 17 09:18:55 sogod [5454]: [ERROR] <0x0x564517b9ca60[NGImap4ConnectionManager]> IMAP4 login failed:
host=mail.company.com, user=username, pwd=yes
url=imaps://username@mail.company.com/?tls=YES
base=(null)
base-class=(null))
= <0x0x56451e740750[NGImap4Client]: login=username(pwd) address=<0x0x56451cdde310[NGInternetSocketAddress]: host=mail.company.com not-filled>>
Jun 17 09:18:55 sogod [5454]: [ERROR] <0x564527705ee0[SOGoMailAccount]:0> Could not connect IMAP4
2019-06-17 09:18:55.939 sogod[5454:5454] GSFromUnicode() No iconv for encoding NSUTF32LittleEndianStringEncoding tried to use UTF-32LE
... message repeats
2019-06-17 09:18:55.951 sogod[5454:5454] GSFromUnicode() No iconv for encoding sNSUTF32LittleEndianStringEncoding tried to use UTF-32LE
Jun 17 09:18:55 sogod [5454]: 212.201.104.11 "POST /SOGo/so/username/Mail/0/foldershared/folderadministrator/folderpurchase/view HTTP/1.1" 500 4/45 0.022 - - 0
Jun 17 09:19:12 sogod [5426]: <0x0x5645175d0cc0[WOWatchDogChild]> child 5454 exited
Jun 17 09:19:12 sogod [5426]: <0x0x5645175d0cc0[WOWatchDogChild]> (terminated due to signal 11, coredump)
Jun 17 09:19:12 sogod [5426]: <0x0x564517456ee0[WOWatchDog]> child spawned with pid 17403
Jun 17 09:19:12 sogod [17403]: <0x0x5645175b07a0[WOHttpAdaptor]> notified the watchdog that we are ready
Jun 17 09:19:14 sogod [17403]: <0x0x5645175c2aa0[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jun 17 09:19:14 sogod [17403]: <0x0x5645175c2aa0[SOGoCache]> Using host(s) 'localhost' as server(s)
Jun 17 09:19:14 sogod [17403]: [ERROR] <0x0x5645172784a0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:19:14 sogod [17403]: [ERROR] <0x0x5645172784a0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:19:14 sogod [17403]: [ERROR] <0x0x564517278410[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:19:14 sogod [17403]: <0x0x56451725cf30[NGImap4Client]> TLS started successfully.
Jun 17 09:19:15 sogod [17403]: [ERROR] <0x0x5645172784a0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:19:15 sogod [17403]: [ERROR] <0x0x5645172784a0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:19:15 sogod [17403]: [ERROR] <0x0x564517278410[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
2019-06-17 09:19:17.484 sogod[17403:17403] parseTimeZone: cannot parse time notation 'UT'
Jun 17 09:19:17 sogod [17403]: 212.201.104.11 "POST /SOGo/so/username/Mail/0/foldershared/folderadministrator/folderpurchase/view HTTP/1.1" 200 30153/45 3.017 - - 19M
Jun 17 09:19:21 sogod [17403]: <0x0x564518859950[NGImap4Client]> TLS started successfully.
Jun 17 09:19:22 sogod [17403]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/unseenCount HTTP/1.1" 200 21/31 1.369 - - 0
Jun 17 09:19:23 sogod [17403]: <0x0x5645188599c0[NGImap4Client]> TLS started successfully.
Jun 17 09:19:23 sogod [17403]: 212.201.104.11 "POST /SOGo/so/lschiesl/Mail/0/folderINBOX/view HTTP/1.1" 200 13493/45 0.936 - - 240K
Jun 17 09:19:33 sogod [17403]: <0x0x56451756ed40[NGImap4Client]> TLS started successfully.
Jun 17 09:19:34 sogod [17403]: 212.201.104.11 "POST /SOGo/so/lschiesl/Mail/unseenCount HTTP/1.1" 200 21/31 0.632 - - 0
Jun 17 09:19:52 sogod [3549]: <0x0x56451a322db0[NGImap4Client]> TLS started successfully.
Jun 17 09:19:53 sogod [17403]: <0x0x5645187f0ca0[NGImap4Client]> TLS started successfully.
Jun 17 09:19:53 sogod [3549]: 212.201.104.11 "POST /SOGo/so/lschiesl/Mail/0/folderINBOX/moveMessages HTTP/1.1" 204 0/82 0.867 - - 0
Jun 17 09:19:53 sogod [17403]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/0/folderINBOX/view HTTP/1.1" 200 31241/45 1.035 - - 800K
Jun 17 09:19:55 sogod [3549]: <0x0x564519cab640[NGImap4Client]> TLS started successfully.
Jun 17 09:19:55 sogod [3549]: 212.201.104.11 "GET /SOGo/so/lschiesl/Mail/0/folderINBOX/1095/view HTTP/1.1" 200 32140/0 1.917 - - 0
Jun 17 09:19:56 sogod [3549]: <0x0x56451a3234e0[NGImap4Client]> TLS started successfully.
Jun 17 09:19:57 sogod [3549]: 212.201.104.11 "GET /SOGo/so/lschiesl/Mail/0/folderINBOX/1095/2/image001.png HTTP/1.1" 200 185/0 0.779 - - -16K
Jun 17 09:20:06 sogod [17403]: [WARN] <0x0x5645178a6030[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jun 17 09:20:06 sogod [17403]: [WARN] <0x0x5645178a6030[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jun 17 09:20:06 sogod [17403]: [WARN] <0x0x5645178a6030[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x5645197d9020[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x5645197d9020[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x564519f381d0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:20:06 sogod [3549]: [ERROR] <0x0x5645197d9020[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:20:06 sogod [17403]: [ERROR] <0x0x564517276380[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:20:06 sogod [17403]: [ERROR] <0x0x564517276380[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:20:06 sogod [17403]: [ERROR] <0x0x56451741ee40[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:20:06 sogod [3549]: 212.201.104.11 "GET /SOGo/so/username/Calendar/eventslist?asc=1&day=20190617&filterpopup=view_today&search=title_Category_Location&sort=start&value= HTTP/1.1" 200 3473/0 0.033 - - 0
Jun 17 09:20:06 sogod [17403]: 212.201.104.11 "GET /SOGo/so/username/Calendar/eventsblocks?ed=20190623&sd=20190617&view=weekview HTTP/1.1" 200 17658/0 0.040 - - 700K
Jun 17 09:20:15 sogod [17403]: [ERROR] <0x0x564517aa4210[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:20:15 sogod [17403]: [ERROR] <0x0x564517aa4210[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:20:15 sogod [17403]: [ERROR] <0x0x5645174e3ac0[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:20:15 sogod [17403]: <0x0x564517122a10[NGImap4Client]> TLS started successfully.
Jun 17 09:20:17 sogod [17403]: 212.201.104.11 "POST /SOGo/so/username/Mail/unseenCount HTTP/1.1" 200 157/150 1.596 - - 0
2019-06-17 09:20:20.925 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:21 sogod [17403]: <0x0x564517f0bcf0[NGImap4Client]> TLS started successfully.
Jun 17 09:20:21 sogod [17403]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/unseenCount HTTP/1.1" 200 21/31 1.032 - - 1M
2019-06-17 09:20:22.043 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:22 sogod [17403]: 192.168.3.10 "OPTIONS /SOGo/dav/avogel/ HTTP/1.1" 401 0/0 0.317 - - 0
2019-06-17 09:20:22.396 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:22 sogod [17403]: 192.168.3.10 "OPTIONS /SOGo/dav/avogel/ HTTP/1.1" 200 0/0 0.418 - - 1M
Jun 17 09:20:22 sogod [17403]: 192.168.3.10 "PROPFIND /SOGo/dav/avogel/Calendar/ HTTP/1.1" 401 0/2161 0.009 - - 0
Jun 17 09:20:23 sogod [17403]: 192.168.3.10 "PROPFIND /SOGo/dav/avogel/Calendar/ HTTP/1.1" 207 1816/2161 0.038 17357 89% 2M
2019-06-17 09:20:23.234 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:23 sogod [17403]: <0x0x564517824a70[NGImap4Client]> TLS started successfully.
Jun 17 09:20:24 sogod [17403]: 192.168.3.10 "POST /SOGo/so/lschiesl/Mail/0/folderINBOX/view HTTP/1.1" 200 12524/45 1.461 - - 84K
2019-06-17 09:20:27.853 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:20:27.904 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:20:28.179 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:20:28.309 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:28 sogod [17403]: 192.168.3.10 "REPORT /SOGo/dav/staff-calendar/Calendar/personal/ HTTP/1.1" 207 125/188 0.566 - - 0
Jun 17 09:20:28 sogod [3549]: 192.168.3.10 "REPORT /SOGo/dav/rwuttke/Calendar/personal/ HTTP/1.1" 207 125/188 0.604 - - 0
2019-06-17 09:20:48.036 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:48 sogod [3549]: <0x0x56451ae40b30[NGImap4Client]> TLS started successfully.
Jun 17 09:20:48 sogod [3549]: 192.168.3.10 "POST /SOGo/so/lschiesl/Mail/unseenCount HTTP/1.1" 200 21/31 0.828 - - 0
2019-06-17 09:20:52.924 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:20:54 sogod [3549]: <0x0x56451b2254a0[NGImap4Client]> TLS started successfully.
Jun 17 09:20:54 sogod [3549]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/0/folderINBOX/view HTTP/1.1" 200 31241/45 1.707 - - 0
Jun 17 09:21:14 sogod [3549]: [ERROR] <0x0x56451b2bb0c0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:21:14 sogod [3549]: [ERROR] <0x0x56451b2bb0c0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:21:14 sogod [3549]: [ERROR] <0x0x56451a0fa650[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:21:14 sogod [3549]: <0x0x5645193704b0[NGImap4Client]> TLS started successfully.
Jun 17 09:21:15 sogod [3549]: [ERROR] <0x0x56451b2bb0c0[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:21:15 sogod [3549]: [ERROR] <0x0x56451b2bb0c0[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:21:15 sogod [3549]: [ERROR] <0x0x56451a0fa650[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
2019-06-17 09:21:15.417 sogod[3549:3549] parseTimeZone: cannot parse time notation 'UT'
Jun 17 09:21:15 sogod [3549]: 212.201.104.11 "POST /SOGo/so/username/Mail/0/foldershared/folderadministrator/folderpurchase/view HTTP/1.1" 200 30153/45 0.882 - - 0
Jun 17 09:21:21 sogod [3549]: <0x0x56451b09a150[NGImap4Client]> TLS started successfully.
Jun 17 09:21:21 sogod [3549]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/unseenCount HTTP/1.1" 200 21/31 0.473 - - 0
Jun 17 09:21:24 sogod [3549]: <0x0x56451add5220[NGImap4Client]> TLS started successfully.
Jun 17 09:21:24 sogod [3549]: 192.168.3.10 "POST /SOGo/so/lschiesl/Mail/0/folderINBOX/view HTTP/1.1" 200 12524/45 0.682 - - 0
Jun 17 09:21:48 sogod [3549]: <0x0x56451ab21970[NGImap4Client]> TLS started successfully.
Jun 17 09:21:48 sogod [3549]: 192.168.3.10 "POST /SOGo/so/lschiesl/Mail/unseenCount HTTP/1.1" 200 21/31 0.370 - - 0
2019-06-17 09:21:53.040 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:21:53.257 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:21:53.349 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:21:53.458 sogod[3549:3549] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:21:53 sogod [3549]: <0x0x56451ad11a70[NGImap4Client]> TLS started successfully.
Jun 17 09:21:54 sogod [3549]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/0/folderINBOX/view HTTP/1.1" 200 31241/45 1.497 - - 0
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x5645197b7dc0[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x5645197b7dc0[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x56451b19f930[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:22:06 sogod [3549]: [ERROR] <0x0x5645197b7dc0[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:22:06 sogod [17403]: [ERROR] <0x0x564517953640[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:22:06 sogod [17403]: [ERROR] <0x0x564517953640[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:22:06 sogod [17403]: [ERROR] <0x0x564517963060[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:22:06 sogod [3549]: 212.201.104.11 "GET /SOGo/so/username/Calendar/eventslist?asc=1&day=20190617&filterpopup=view_today&search=title_Category_Location&sort=start&value= HTTP/1.1" 200 3473/0 0.029 - - 0
Jun 17 09:22:06 sogod [17403]: 212.201.104.11 "GET /SOGo/so/username/Calendar/eventsblocks?ed=20190623&sd=20190617&view=weekview HTTP/1.1" 200 17658/0 0.039 - - 0
Jun 17 09:22:15 sogod [17403]: [ERROR] <0x0x56451792f480[GSCBufferString]> json parser: Expected value while parsing array, attempting once more after unescaping...
Jun 17 09:22:15 sogod [17403]: [ERROR] <0x0x56451792f480[GSCBufferString]> total failure. Original string is: {: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}
Jun 17 09:22:15 sogod [17403]: [ERROR] <0x0x564517939e70[SOGoSQLUserProfile]> failure parsing json string: '{: {: [, , , , , , , ], : , : {: , : , : , : , : , : , : }, : {: 0, : 0, : 0, : 0, : 0, : 0, : 0}, : {: 0}, : , : {: , : , : , : , : , : , : }, : , : {: 1, : 1, : 1, : 1, : 1, : 1, : 0}, : [, , , , , , ], : [], : {: 0}, : {: 0}, : {: 1}, : , : [, ]}, : {: [, ]}, : {: , : [], : {: }}, : , : {: [, , , , , ], : [, ]}}'
Jun 17 09:22:15 sogod [17403]: <0x0x564517257930[NGImap4Client]> TLS started successfully.
Jun 17 09:22:16 sogod [17403]: 212.201.104.11 "POST /SOGo/so/username/Mail/unseenCount HTTP/1.1" 200 157/150 0.749 - - 0
2019-06-17 09:22:21.703 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:22:21.799 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:22:21.894 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:22:22.194 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
2019-06-17 09:22:22.421 sogod[17403:17403] Creating NGLdapConnection instance for bindDN 'cn=user,dc=ldap,dc=company,dc=com'
Jun 17 09:22:22 sogod [17403]: <0x0x564517f086f0[NGImap4Client]> TLS started successfully.
Jun 17 09:22:23 sogod [17403]: 84.63.38.46 "POST /SOGo/so/drebelo/Mail/unseenCount HTTP/1.1" 200 21/31 1.590 - - 0
|
 |
Can you dump the users account with sogo-tool? |
|
|
The users can log in and sogo creates a new profile for them, afaik. We can offer backuped profile from previous day, before the error occurred, are you interested in these? |
| Date Modified | Username | Field | Change |
|---|---|---|---|
| 2019-06-17 07:56 | ondrej.kolin | New Issue | |
| 2019-06-17 07:56 | ondrej.kolin | File Added: sogo_error.txt | |
| 2019-06-18 09:59 | Christian Mack | Note Added: 0013646 | |
| 2019-07-18 06:20 | ondrej.kolin | Note Added: 0013672 |
