On 11.09.14 15:22, Cyrus Daboo wrote:
> Hi Ulrich,
>
> --On September 11, 2014 at 3:15:04 PM +0200 Ulrich Fourier
> <ulrich.four...@rockyourlife.de> wrote:
>
>> Could it be a storage problem, I want to store the calendar on the
>> filesystem not in a postgresql?
>
> Don't do that. The file store is now only supported as a means of
> migrating from legacy file store to the SQL store. All the new
> functionality we build is going into the SQL store. As a result the
> file store may well be broken for operations other than the migration
> step we use it for.
>
> That said the problem you are seeing may not be related to that. A
> browser should definitely work - in fact that is probably the first
> and easiest thing to try. The errors you saw with the browser
> suggestion some problem with perhaps using SSL when that isn't
> enabled. So I suggest you check that again. If you have no luck, turn
> the server off, clear out the error log file, then turn it on again
> and try again with the browser. Send the log file and we can look at
> the whole startup process and maybe spot the issue.
>
Hi Cyrus,
thank you, in that case I will setup a database.
I attached both log files, I hope that they are helpful.
Uli
Log opened - server start: [Thu Sep 11 16:13:33 2014].
88.217.236.30 - - [11/Sep/2014:16:13:45 +0200] "GET / HTTP/1.1" 304 0 "-"
"Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/37.0.2062.120 Safari/537.36" i=0 t=21.5 or=1
88.217.236.30 - - [11/Sep/2014:16:13:45 +0200] "GET /favicon.ico HTTP/1.1" 401
141 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.36
(KHTML, like Gecko) Chrome/37.0.2062.120 Safari/537.36" i=0 t=6.0 or=1
88.217.236.30 - - [11/Sep/2014:16:13:47 +0200] "GET /calendars/ HTTP/1.1" 401
141 "https://rockyourlife.de:8843/"; "Mozilla/5.0 (Macintosh; Intel Mac OS X
10_7_5) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/37.0.2062.120
Safari/537.36" i=0 t=5.3 or=1
88.217.236.30 - - [11/Sep/2014:16:13:56 +0200] "GET /calendars/ HTTP/1.1" 401
330 "https://rockyourlife.de:8843/"; "Mozilla/5.0 (Macintosh; Intel Mac OS X
10_7_5) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/37.0.2062.120
Safari/537.36" i=0 t=8.1 or=1
88.217.236.30 - - [11/Sep/2014:16:14:39 +0200] "GET /calendars/ HTTP/1.1" 401
141 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.36
(KHTML, like Gecko) Chrome/37.0.2062.120 Safari/537.36" i=0 t=3.9 or=1
88.217.236.30 - - [11/Sep/2014:16:14:47 +0200] "GET /calendars/ HTTP/1.1" 401
330 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.36
(KHTML, like Gecko) Chrome/37.0.2062.120 Safari/537.36" i=0 t=6.3 or=1
88.217.236.30 - - [11/Sep/2014:16:15:05 +0200] "GET /calendars/ HTTP/1.1" 401
141 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.36
(KHTML, like Gecko) Chrome/37.0.2062.120 Safari/537.36" i=0 t=3.6 or=1
Log closed - server stop: [Thu Sep 11 16:15:28 2014].
2014-09-11 16:13:33+0200 [-] Log opened.
2014-09-11 16:13:33+0200 [-] twistd 12.0.0 (/usr/bin/python2.7 2.7.3) starting
up.
2014-09-11 16:13:33+0200 [-] reactor class:
twisted.internet.pollreactor.PollReactor.
2014-09-11 16:13:33+0200 [-] AMPLoggingFactory starting on '/tmp/caldavd.sock'
2014-09-11 16:13:33+0200 [-] [calendarserver.accesslog#debug]
rotateGlobalHitHistoryStats: [{'hits': 0, 'time': 1410444813}, {'hits': 0,
'time': 1410444813}, {'hits': 0, 'time': 1410444813}, {'hits': 0, 'time':
1410444813}, {'hits': 0, 'time': 1410444813}, {'hits': 0, 'time': 1410444813},
{'hits': 0, 'time': 1410444813}, {'hits': 0, 'time': 1410444813}, {'hits': 0,
'time': 1410444813}, {'hits': 0, 'time': 1410444813}, {'hits': 0, 'time':
1410444813}, {'hits': 0, 'time': 1410444813}, {'hits': 0, 'time': 1410444813}]
2014-09-11 16:13:33+0200 [-] CalDAVStatisticsServer starting on
'/tmp/caldavd-stats.sock'
2014-09-11 16:13:33+0200 [-] LimitingInheritingProtocolFactory starting on 8008
2014-09-11 16:13:33+0200 [-] LimitingInheritingProtocolFactory starting on 8443
2014-09-11 16:13:33+0200 [-] LimitingInheritingProtocolFactory starting on 8843
2014-09-11 16:13:33+0200 [-]
[calendarserver.tap.caldav.CalDAVServiceMaker#info] Adding group caching service
2014-09-11 16:13:33+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-] Log
opened.
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-] twistd
12.0.0 (/usr/bin/python2.7 2.7.3) starting up.
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-] reactor
class: twisted.internet.selectreactor.SelectReactor.
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacherService#warn] Starting
group membership cacher service
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] is
group-cacher-populated
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] Getting Cache
Token for 'group-cacher-populated'
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.memcachepool.MemCachePool#debug] Initating new client connection
to: IPv4Address(TCP, '127.0.0.1', 11211)
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[Uninitialized] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[Uninitialized] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free:
0, #busy: 1, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Updating
group membership cache
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Group
membership snapshot file exists: /var/www/caldavd/Data/memberships_cache
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Attempting
to acquire group membership cache lock
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] add
group-cacher-lock
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] Adding Cache
Token for 'group-cacher-lock'
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Acquired
lock
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Retrieving
list of all proxies
2014-09-11 16:13:34+0200 [-] [caldav-1] Reading configuration from file:
/etc/caldavd/caldavd.plist
2014-09-11 16:13:34+0200 [-] [caldav-1] [-] Log opened.
2014-09-11 16:13:34+0200 [-] [caldav-1] [-] twistd 12.0.0 (/usr/bin/python2.7
2.7.3) starting up.
2014-09-11 16:13:34+0200 [-] [caldav-1] [-] reactor class:
twisted.internet.selectreactor.SelectReactor.
2014-09-11 16:13:34+0200 [-] [caldav-0] Reading configuration from file:
/etc/caldavd/caldavd.plist
2014-09-11 16:13:34+0200 [-] [caldav-0] [-] Log opened.
2014-09-11 16:13:34+0200 [-] [caldav-0] [-] twistd 12.0.0 (/usr/bin/python2.7
2.7.3) starting up.
2014-09-11 16:13:34+0200 [-] [caldav-0] [-] reactor class:
twisted.internet.selectreactor.SelectReactor.
2014-09-11 16:13:34+0200 [calendarserver.accesslog.AMPLoggingFactory]
AMPLoggingProtocol connection established
(HOST:UNIXAddress('/tmp/caldavd.sock') PEER:UNIXAddress(''))
2014-09-11 16:13:34+0200 [calendarserver.accesslog.AMPLoggingFactory]
AMPLoggingProtocol connection established
(HOST:UNIXAddress('/tmp/caldavd.sock') PEER:UNIXAddress(''))
2014-09-11 16:13:34+0200 [-] [caldav-0] [-] AMP connection established
(HOST:UNIXAddress(None) PEER:UNIXAddress('/tmp/caldavd.sock'))
2014-09-11 16:13:34+0200 [-] [caldav-1] [-] AMP connection established
(HOST:UNIXAddress(None) PEER:UNIXAddress('/tmp/caldavd.sock'))
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.database#debug] Starting ADBAPI thread: 139860540520192
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] There are
0 proxies
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Retrieving
group hierarchy from directory
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] 0 groups
retrieved from the directory
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] 0 groups
are proxies
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] There are
0 users delegated-to via groups
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Taking
snapshot of group memberships to /var/www/caldavd/Data/memberships_cache
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Storing 0
group memberships in memcached
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] set
group-cacher-populated
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] Setting Cache
Token for 'group-cacher-populated'
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200 [-]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Releasing
lock
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] delete
group-cacher-lock
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCache#debug] Deleting Cache
Token for 'group-cacher-lock'
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at
0x4309680>
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug]
Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacheUpdater#info] Group
memberships cache updated
2014-09-11 16:13:34+0200 [-] [groupcacher] 2014-09-11 16:13:34+0200
[PooledMemCacheProtocol,client]
[twistedcaldav.directory.directory.GroupMembershipCacherService#info]
Scheduling next group membership update
2014-09-11 16:13:34+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:13:36+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:13:40+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:13:45+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twext.web2.server#info] GET / HTTP/1.1
2014-09-11 16:13:45+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twext.web2.server#info] GET /favicon.ico HTTP/1.1
2014-09-11 16:13:45+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '784053266912630745292173428306800341612334858145875887617'
2014-09-11 16:13:45+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Initating new client connection
to: IPv4Address(TCP, '127.0.0.1', 11211)
2014-09-11 16:13:45+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:45+0200 [-] [caldav-0] [Uninitialized]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:45+0200 [-] [caldav-0] [Uninitialized]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '784053266912630745292173428306800341612334858145875887617'
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:45+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:47+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:13:47+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '63031744201064215908719688380183090337702875212563411934'
2014-09-11 16:13:47+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:47+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '63031744201064215908719688380183090337702875212563411934'
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:48+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:13:56+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:13:56+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '63031744201064215908719688380183090337702875212563411934'
2014-09-11 16:13:56+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:56+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache:
checking
dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|UlrichFourier|users|groups
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache:
miss
dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|UlrichFourier|users|groups
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Faulting
record for attribute 'shortname' with value 'UlrichFourier'
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] LDAP query
for types ['users'], indexType shortname and indexKey UlrichFourier
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Retrieving
ldap record with base ou=people,dc=rockyourlife,dc=de and filter
(&(&(!(objectClass=organizationalUnit))(objectClass=inetOrgPerson))(dn=UlrichFourier)).
2014-09-11 16:13:56+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.extensions#info] Could not find the principal resource for user
id: UlrichFourier
2014-09-11 16:14:04+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:14:36+0200 [-] [memcached-Default] can't run as root without the
-u switch
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '286579884750953364325102881126432113315786597146508329742'
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,1,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '286579884750953364325102881126432113315786597146508329742'
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Exception rendering:
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.AttributeError'>: 'Server' object has no attribute 'protocol'
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:712:registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/_newtls.py:231:registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0] ]
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Exception rendering error page:
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.ValueError'>: registering producer
<twext.web2.stream.StreamProducer object at 0x3c6f090> before previous one
(<twext.web2.stream.StreamProducer object at 0x3c6abd0>) was unregistered
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:705:registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0] ]
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Original exception:
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.AttributeError'>: 'Server' object has no attribute 'protocol'
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:712:registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/_newtls.py:231:registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0] ]
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
Unhandled error in Deferred:
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
Unhandled Error
2014-09-11 16:14:39+0200 [-] [caldav-0] Traceback (most recent call
last):
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 551, in
_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] current.result =
callback(current.result, *args, **kw)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/server.py", line 619, in
_processingFailed
2014-09-11 16:14:39+0200 [-] [caldav-0]
d.addErrback(self._processingReallyFailed, reason)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 312, in
addErrback
2014-09-11 16:14:39+0200 [-] [caldav-0] errbackKeywords=kw)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 290, in
addCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] self._runCallbacks()
2014-09-11 16:14:39+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 551, in
_runCallbacks
2014-09-11 16:14:39+0200 [-] [caldav-0] current.result =
callback(current.result, *args, **kw)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/server.py", line 635, in
_processingReallyFailed
2014-09-11 16:14:39+0200 [-] [caldav-0] self.writeResponse(response)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py", line 125, in
writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0] return
super(SSLRedirectRequest, self).writeResponse(response)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/http.py", line 505, in
writeResponse
2014-09-11 16:14:39+0200 [-] [caldav-0] d =
stream.StreamProducer(response.stream).beginProducing(self.chanRequest)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/stream.py", line 749, in
beginProducing
2014-09-11 16:14:39+0200 [-] [caldav-0]
self.consumer.registerProducer(self, True)
2014-09-11 16:14:39+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py", line 705, in
registerProducer
2014-09-11 16:14:39+0200 [-] [caldav-0] raise ValueError,
"registering producer %s before previous one (%s) was unregistered" %
(producer, self.producer)
2014-09-11 16:14:39+0200 [-] [caldav-0] exceptions.ValueError:
registering producer <twext.web2.stream.StreamProducer object at 0x3c6f2d0>
before previous one (<twext.web2.stream.StreamProducer object at 0x3c6abd0>)
was unregistered
2014-09-11 16:14:39+0200 [-] [caldav-0]
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '862554574725466381433499852097166246014720303348863535510'
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '862554574725466381433499852097166246014720303348863535510'
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:39+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:14:47+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:14:47+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '862554574725466381433499852097166246014720303348863535510'
2014-09-11 16:14:47+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:47+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache:
checking
dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|UlrichFourier|users|groups
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache:
miss
dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|UlrichFourier|users|groups
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Faulting
record for attribute 'shortname' with value 'UlrichFourier'
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] LDAP query
for types ['users'], indexType shortname and indexKey UlrichFourier
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Retrieving
ldap record with base ou=people,dc=rockyourlife,dc=de and filter
(&(&(!(objectClass=organizationalUnit))(objectClass=inetOrgPerson))(dn=UlrichFourier)).
2014-09-11 16:14:47+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.extensions#info] Could not find the principal resource for user
id: UlrichFourier
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '349544046306628998052557274982693993346640269403649950367'
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,2,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '349544046306628998052557274982693993346640269403649950367'
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Exception rendering:
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.AttributeError'>: 'Server' object has no attribute 'protocol'
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:712:registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/_newtls.py:231:registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0] ]
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Exception rendering error page:
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.ValueError'>: registering producer
<twext.web2.stream.StreamProducer object at 0x3c74990> before previous one
(<twext.web2.stream.StreamProducer object at 0x3c74650>) was unregistered
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:705:registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0] ]
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#info] Original exception:
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twext.web2.server#error] [Failure instance: Traceback: <type
'exceptions.AttributeError'>: 'Server' object has no attribute 'protocol'
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/server.py:651:_cbFinishRender
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:368:callback
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:464:_startRunCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/defer.py:551:_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:125:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/http.py:505:writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/stream.py:749:beginProducing
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py:712:registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0]
/usr/lib/python2.7/dist-packages/twisted/internet/_newtls.py:231:registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0] ]
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
Unhandled error in Deferred:
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
Unhandled Error
2014-09-11 16:15:05+0200 [-] [caldav-0] Traceback (most recent call
last):
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 551, in
_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] current.result =
callback(current.result, *args, **kw)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/server.py", line 619, in
_processingFailed
2014-09-11 16:15:05+0200 [-] [caldav-0]
d.addErrback(self._processingReallyFailed, reason)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 312, in
addErrback
2014-09-11 16:15:05+0200 [-] [caldav-0] errbackKeywords=kw)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 290, in
addCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] self._runCallbacks()
2014-09-11 16:15:05+0200 [-] [caldav-0] --- <exception caught here> ---
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twisted/internet/defer.py", line 551, in
_runCallbacks
2014-09-11 16:15:05+0200 [-] [caldav-0] current.result =
callback(current.result, *args, **kw)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/server.py", line 635, in
_processingReallyFailed
2014-09-11 16:15:05+0200 [-] [caldav-0] self.writeResponse(response)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py", line 125, in
writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0] return
super(SSLRedirectRequest, self).writeResponse(response)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/http.py", line 505, in
writeResponse
2014-09-11 16:15:05+0200 [-] [caldav-0] d =
stream.StreamProducer(response.stream).beginProducing(self.chanRequest)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/stream.py", line 749, in
beginProducing
2014-09-11 16:15:05+0200 [-] [caldav-0]
self.consumer.registerProducer(self, True)
2014-09-11 16:15:05+0200 [-] [caldav-0] File
"/usr/lib/python2.7/dist-packages/twext/web2/channel/http.py", line 705, in
registerProducer
2014-09-11 16:15:05+0200 [-] [caldav-0] raise ValueError,
"registering producer %s before previous one (%s) was unregistered" %
(producer, self.producer)
2014-09-11 16:15:05+0200 [-] [caldav-0] exceptions.ValueError:
registering producer <twext.web2.stream.StreamProducer object at 0x3c74bd0>
before previous one (<twext.web2.stream.StreamProducer object at 0x3c74650>)
was unregistered
2014-09-11 16:15:05+0200 [-] [caldav-0]
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,3,88.217.236.30]
[twext.web2.server#info] GET /calendars/ HTTP/1.1
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,3,88.217.236.30]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache
Token for '170798008080117901036634924262781803562131911468485813676'
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,3,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [HTTPChannel,3,88.217.236.30]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache
Token for '170798008080117901036634924262781803562131911468485813676'
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Busied client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1,
#pending: 0, #queued: 0
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Freed client:
<twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x3b7add0>
2014-09-11 16:15:05+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
[twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0,
#pending: 0, #queued: 0
2014-09-11 16:15:28+0200 [-] Received SIGINT, shutting down.
2014-09-11 16:15:28+0200 [AMPLoggingProtocol,0,] AMPLoggingProtocol connection
lost (HOST:UNIXAddress('/tmp/caldavd.sock') PEER:UNIXAddress(''))
2014-09-11 16:15:28+0200 [-] [caldav-0] [-] Received SIGINT, shutting down.
2014-09-11 16:15:28+0200 [-] [caldav-0] [PooledMemCacheProtocol,client]
Received SIGTERM, shutting down.
2014-09-11 16:15:28+0200 [-] [caldav-0] [AMP,client] AMP connection lost
(HOST:UNIXAddress(None) PEER:UNIXAddress('/tmp/caldavd.sock'))
2014-09-11 16:15:28+0200 [-] [caldav-0] [-] Main loop terminated.
2014-09-11 16:15:28+0200 [-] [caldav-1] [-] Received SIGINT, shutting down.
2014-09-11 16:15:28+0200 [-] [caldav-1] [AMP,client] Received SIGTERM,
shutting down.
2014-09-11 16:15:28+0200 [-] [caldav-1] [AMP,client] AMP connection lost
(HOST:UNIXAddress(None) PEER:UNIXAddress('/tmp/caldavd.sock'))
2014-09-11 16:15:28+0200 [-] [caldav-1] [-] Main loop terminated.
2014-09-11 16:15:28+0200 [-] [caldav-1] [-] Server Shut Down.
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-]
Received SIGINT, shutting down.
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-]
[twistedcaldav.directory.directory.GroupMembershipCacherService#warn] Stopping
group membership cacher service
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-]
Received SIGTERM, shutting down.
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-]
[twistedcaldav.database#debug] Closing ADBAPI thread: 139860540520192
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-] Main
loop terminated.
2014-09-11 16:15:28+0200 [-] [groupcacher] 2014-09-11 16:15:28+0200 [-] Server
Shut Down.
2014-09-11 16:15:28+0200 [-] (TCP Port 8843 Closed)
2014-09-11 16:15:28+0200 [-] (TCP Port 8443 Closed)
2014-09-11 16:15:28+0200 [-] (TCP Port 8008 Closed)
2014-09-11 16:15:28+0200 [-] (UNIX Port '/tmp/caldavd-stats.sock' Closed)
2014-09-11 16:15:28+0200 [-] (UNIX Port '/tmp/caldavd.sock' Closed)
2014-09-11 16:15:28+0200 [AMPLoggingProtocol,1,] AMPLoggingProtocol connection
lost (HOST:UNIXAddress('/tmp/caldavd.sock') PEER:UNIXAddress(''))
2014-09-11 16:15:28+0200 [-] [caldav-0] [-] Server Shut Down.
_______________________________________________
calendarserver-users mailing list
calendarserver-users@lists.macosforge.org
https://lists.macosforge.org/mailman/listinfo/calendarserver-users
