Hi,
I updated SOGo to 1.3.13 today (Debian Squeeze via aptitude) and since
then iCal access to caldav doesn't work any longer:
Whenever iCal tries to access the calendar the following error pops up:
The server responded with "502"
to operation CalDAVRefreshDelegateListQueueableOperation.
SOGo log says the following:
<client IP> - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/
HTTP/1.1" 401 0/181 0.001 - - 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/
HTTP/1.1" 207 438/181 0.088 - - 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/
HTTP/1.1" 401 0/181 0.001 - - 0
localhost - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/ HTTP/1.1"
401 0/181 0.001 - - 4K
localhost - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/ HTTP/1.1"
207 438/181 0.002 - - 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/kb/
HTTP/1.1" 207 600/823 0.003 1868 67% 24K
<client IP> - - [19/Mar/2012:13:31:40 GMT] "OPTIONS /SOGo/dav/kb/
HTTP/1.1" 200 0/0 0.002 - - 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "PROPFIND /SOGo/dav/kb/
HTTP/1.1" 207 600/823 0.002 1868 67% 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "OPTIONS /SOGo/dav/kb/
HTTP/1.1" 200 0/0 0.001 - - 0
<client IP> - - [19/Mar/2012:13:31:40 GMT] "REPORT /SOGo/dav/ HTTP/1.1"
207 302/89 0.001 1210 75% 4K
<client IP> - - [19/Mar/2012:13:31:41 GMT] "PROPFIND
/SOGo/dav/kb/Calendar/ HTTP/1.1" 207 1661/1925 0.460 10363 83% 0
<client IP> - - [19/Mar/2012:13:31:41 GMT] "PROPFIND
/SOGo/dav/kb/Calendar/personal/ HTTP/1.1" 207 409/181 0.004 - - 0
<client IP> - - [19/Mar/2012:13:31:41 GMT] "PROPFIND
/SOGo/dav/kb/Calendar/personal/ HTTP/1.1" 207 332/145 0.004 - - 8K
<client IP> - - [19/Mar/2012:13:31:41 GMT] "PROPFIND
/SOGo/dav/kb/Calendar/inbox/ HTTP/1.1" 207 398/181 0.002 - - 0
Mar 19 13:31:41 sogod [25706]: [ERROR]
<0x024A6930[SOGoAppointmentInboxFolder]:inbox> (-[SOGoGCSFolder
toOneRelationshipKeys]): fetch failed!
<client IP> - - [19/Mar/2012:13:31:41 GMT] "PROPFIND
/SOGo/dav/kb/Calendar/inbox/ HTTP/1.1" 207 329/145 0.002 - - 0
WARNING: Using default signature for davEmailAddressSet ... either the
method for that selector is not implemented by the receiver, or you must
be using an old/faulty version of the Objective-C runtime library.
EXCEPTION: <NSException: 0x2858f20> NAME:NSInvalidArgumentException
REASON:Can not determine type information for -[SOGoUserFolder
davEmailAddressSet] INFO:(nil)
Mar 19 13:31:41 sogod [23991]: <0x0x2138d00[WOWatchDogChild]> child
25706 exited
Mar 19 13:31:41 sogod [23991]: <0x0x2138d00[WOWatchDogChild]>
(terminated due to signal 6)
Mar 19 13:31:41 sogod [23991]: <0x0x2201ed0[WOWatchDog]> child spawned
with pid 25818
Mar 19 13:31:41 sogod [25818]: <0x0x23f32d0[SOGoCache]> Cache cleanup
interval set every 5.000000 seconds
Mar 19 13:31:41 sogod [25818]: <0x0x23f32d0[SOGoCache]> Using host(s)
'localhost' as server(s)
Mar 19 13:31:41 sogod [25818]: [WARN]
<0x0x24896e0[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists
in DAV permissions table
Mar 19 13:31:41 sogod [25818]: [WARN]
<0x0x24896e0[SOGoWebDAVAclManager]> entry '{DAV:}write-properties'
already exists in DAV permissions table
Mar 19 13:31:41 sogod [25818]: [WARN]
<0x0x24896e0[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already
exists in DAV permissions table
WARNING: Using default signature for davEmailAddressSet ... either the
method for that selector is not implemented by the receiver, or you must
be using an old/faulty version of the Objective-C runtime library.
EXCEPTION: <NSException: 0x24b3580> NAME:NSInvalidArgumentException
REASON:Can not determine type information for -[SOGoUserFolder
davEmailAddressSet] INFO:(nil)
Mar 19 13:31:41 sogod [23991]: <0x0x2138d00[WOWatchDogChild]> child
25818 exited
Mar 19 13:31:41 sogod [23991]: <0x0x2138d00[WOWatchDogChild]>
(terminated due to signal 6)
Mar 19 13:31:41 sogod [23991]: <0x0x2138d00[WOWatchDogChild]> avoiding
to respawn child before 2012-03-19 13:31:46 +0100
Mar 19 13:31:46 sogod [23991]: <0x0x2201ed0[WOWatchDog]> child spawned
with pid 25820
When that happens, the apache error log says:
[Mon Mar 19 12:31:41 2012] [error] [client IP] (20014)Internal error:
proxy: error reading status line from remote server 127.0.0.1:20000
[Mon Mar 19 12:31:41 2012] [error] [client IP] proxy: Error reading from
remote server returned by /SOGo/dav/kb/
I'm puzzled, as I didn't change anything besides doing the upgrade. Any
clues what could have happened?
BTW, other caldav Clients and the webfrontend work as excpected.
And sometimes, I don't know exactly when so it's hard to reproduce, but
it also only happens when trying to access the calendar via ical log
lines like the following appear:
2012-03-19 13:05:28.310 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of escape in a string literal
LINE 1: ...c_foldername FROM sogo_folder_info WHERE c_path = '/Users/kb...
^
HINT: Use the escape string syntax for escapes, e.g., E'\r\n'.
2012-03-19 13:05:28.311 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of escape in a string literal
LINE 1: ...c_foldername FROM sogo_folder_info WHERE c_path = '/Users/ac...
^
HINT: Use the escape string syntax for escapes, e.g., E'\r\n'.
2012-03-19 13:05:28.350 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-13-75155F80'':
<PostgreSQL72Exception: 0x28bf030> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-13-75155F80''
2012-03-19 13:05:28.351 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-13-75155F80'':
<PostgreSQL72Exception: 0x2914bc0> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-13-75155F80''
2012-03-19 13:05:28.353 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of escape in a string literal
LINE 1: ...c_foldername FROM sogo_folder_info WHERE c_path = '/Users/ac...
^
HINT: Use the escape string syntax for escapes, e.g., E'\r\n'.
2012-03-19 13:05:28.354 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-11-75155F80'':
<PostgreSQL72Exception: 0x280bd10> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-11-75155F80''
2012-03-19 13:05:28.356 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-11-75155F80'':
<PostgreSQL72Exception: 0x28b0b30> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-11-75155F80''
2012-03-19 13:05:28.357 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of escape in a string literal
LINE 1: ...c_foldername FROM sogo_folder_info WHERE c_path = '/Users/ac...
^
HINT: Use the escape string syntax for escapes, e.g., E'\r\n'.
2012-03-19 13:05:28.359 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-F-75155F80'':
<PostgreSQL72Exception: 0x278c550> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-F-75155F80''
2012-03-19 13:05:28.360 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-F-75155F80'':
<PostgreSQL72Exception: 0x2487cb0> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C400-F-75155F80''
2012-03-19 13:05:28.361 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of escape in a string literal
LINE 1: ...c_foldername FROM sogo_folder_info WHERE c_path = '/Users/ac...
^
HINT: Use the escape string syntax for escapes, e.g., E'\r\n'.
2012-03-19 13:05:28.363 sogod[25430] <0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C380-D-75155F80'':
<PostgreSQL72Exception: 0x2688d40> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x2567cc0[PostgreSQL72Channel]:
connection=<0x0x2950a80[PGConnection]: connection=0x0x25eb260>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager folderAtPath:]): executing SQL failed: '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
= 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C380-D-75155F80''
2012-03-19 13:05:28.364 sogod[25430] <0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>:
message: WARNING: nonstandard use of \' in a string literal
LINE 1: ...h1 = 'Users' AND c_path2 = 'aconet' AND c_path3 = 'Calendar\...
^
HINT: Use '' to write quotes in strings, or use the escape string
syntax (E'...').
Mar 19 13:05:28 sogod [25430]: <0x0x2191de0[GCSFolderManager]>
ERROR(-[GCSFolderManager performSQL:]): cannot execute
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 = 'aconet' AND c_path3 = 'Calendar\' AND c_path4 =
'2C65-4F33C380-D-75155F80'':
<PostgreSQL72Exception: 0x26fb190> NAME:PostgreSQL72FatalError
REASON:fatal pgsql error (channel=<0x0x28772b0[PostgreSQL72Channel]:
connection=<0x0x24c72e0[PGConnection]: connection=0x0x2ac9410>>):
ERROR: syntax error at or near "2"
LINE 1: ...'aconet' AND c_path3 = 'Calendar\' AND c_path4 = '2C65-4F33C...
^
Any help or hints would be very much appreciated,
best regards,
Kurt
--
Kurt Bauer <[email protected]>
Vienna University Computer Center - ACOnet - VIX
Universitaetsstrasse 7, A-1010 Vienna, Austria, Europe
Tel: ++43 1 4277 - 14070 (Fax: - 9140) KB1970-RIPE
--
[email protected]
https://inverse.ca/sogo/lists
