[CalendarServer-users] Connection aborted - took too long to close

Jacques Distler distler at golem.ph.utexas.edu
Wed Feb 4 11:45:44 PST 2015 

>> Well, that's the thing.
>> 
>> There ARE NO other errors except for the
>> 
>> [twext.web2.channel.http#error] Connection aborted - took too long to close: ...
>> 
>> errors. So I don't know what exactly is timing out.
> 
> Try setting DefaultLogLevel to ‘info’ in caldavd.plist, then bounce the service or HUP the master process.

Did that, but it looked completely uninformative (at least to my naive eyes):

2015-02-04 13:27:34-0600 [-] [caldav-0]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] REPORT /calendars/__uids__/0B812998-36F7-58B1-B9F210688/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-3]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-2]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-1]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] REPORT /calendars/__uids__/899218B0-7F36-58B1-B921-BBE24F210688/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-4]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-3]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-5]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] REPORT /calendars/__uids__/0B812998-36F7-58B1-B921-BBE24F210688/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-6]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] REPORT /calendars/__uids__/899218B0-7F36-58B1-B921-BBE24F210688/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-7]  [HTTPChannel,1,128.83.114.62] [twext.web2.server#info] OPTIONS /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-2]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] OPTIONS /principals/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-2]  [HTTPChannel,3,128.83.114.62] [twext.web2.server#info] REPORT /principals/ HTTP/1.1
2015-02-04 13:27:34-0600 [-] [caldav-0]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] REPORT /principals/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-1]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] REPORT /principals/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-4]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] REPORT /principals/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-4]  [HTTPChannel,3,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/inbox/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-3]  [HTTPChannel,3,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/inbox/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-7]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/inbox/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-2]  [HTTPChannel,4,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/inbox/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-2]  [HTTPChannel,5,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-0]  [HTTPChannel,3,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-0]  [HTTPChannel,4,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-5]  [HTTPChannel,2,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/E8983642-8809-5ED0-9EDE-60D056E0A81B/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-1]  [HTTPChannel,3,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-1]  [HTTPChannel,4,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/calendar/ HTTP/1.1
2015-02-04 13:27:35-0600 [-] [caldav-1]  [HTTPChannel,5,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/calendar/ HTTP/1.1
2015-02-04 13:27:50-0600 [-] [caldav-5]  [-] [twext.web2.channel.http#error] Connection aborted - took too long to close: IPv4Address(TCP, '128.83.114.62', 58184)
2015-02-04 13:27:51-0600 [-] [caldav-1]  [-] [twext.web2.channel.http#error] Connection aborted - took too long to close: IPv4Address(TCP, '128.83.114.62', 58187)
2015-02-04 13:27:51-0600 [-] [caldav-1]  [HTTPChannel,6,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:27:51-0600 [-] [caldav-1]  [HTTPChannel,7,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/0C1DD05F-B1A8-4FCC-AF33-3153FE8C2598/ HTTP/1.1
2015-02-04 13:27:51-0600 [-] [caldav-1]  [HTTPChannel,8,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/0C1DD05F-B1A8-4FCC-AF33-3153FE8C2598/ HTTP/1.1
2015-02-04 13:28:07-0600 [-] [caldav-1]  [-] [twext.web2.channel.http#error] Connection aborted - took too long to close: IPv4Address(TCP, '128.83.114.62', 58198)
2015-02-04 13:28:07-0600 [-] [caldav-1]  [HTTPChannel,9,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:07-0600 [-] [caldav-1]  [HTTPChannel,10,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:07-0600 [-] [caldav-1]  [HTTPChannel,11,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/EE2AF72D-B267-4879-A5D9-0C828B0D9AB2/ HTTP/1.1
2015-02-04 13:28:07-0600 [-] [caldav-1]  [HTTPChannel,12,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/EE2AF72D-B267-4879-A5D9-0C828B0D9AB2/ HTTP/1.1
2015-02-04 13:28:22-0600 [-] [caldav-1]  [-] [twext.web2.channel.http#error] Connection aborted - took too long to close: IPv4Address(TCP, '128.83.114.62', 58218)
2015-02-04 13:28:22-0600 [-] [caldav-1]  [HTTPChannel,13,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:22-0600 [-] [caldav-1]  [HTTPChannel,14,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/4488DD5D-A3B5-44B5-8783-1AEBF1A5F092/ HTTP/1.1
2015-02-04 13:28:22-0600 [-] [caldav-1]  [HTTPChannel,15,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/4488DD5D-A3B5-44B5-8783-1AEBF1A5F092/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [-] [twext.web2.channel.http#error] Connection aborted - took too long to close: IPv4Address(TCP, '128.83.114.62', 58221)
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,16,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,17,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,18,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/tasks/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,19,128.83.114.62] [twext.web2.server#info] PROPFIND /calendars/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/tasks/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,20,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,20,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,21,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/__uids__/7BF5AE6F-FC81-50C8-91F6-11655A90C3A2/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,22,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,23,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,24,128.83.114.62] [twext.web2.server#info] PROPFIND / HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,25,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2015-02-04 13:28:38-0600 [-] [caldav-1]  [HTTPChannel,26,128.83.114.62] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 235 bytes
Desc: Message signed with OpenPGP using GPGMail
URL: <https://lists.macosforge.org/pipermail/calendarserver-users/attachments/20150204/5315b978/attachment.sig>

More information about the calendarserver-users mailing list