[horde] User cannot delete self created calender entries

Andreas Mauser andreas at mauser.info
Tue Jun 19 20:35:05 UTC 2018


Hi,

a user can create appointments in his calender via 9folders-Android  
App, and/or in the Webmail GUI.

The user cannot delete the appointment then.

Please find the log below. Can I please have a direction?


[655][2018-06-19T22:26:54+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[655][2018-06-19T22:26:54+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[655][2018-06-19T22:26:54+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[655][2018-06-19T22:26:54+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[655][2018-06-19T22:26:54+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[655][2018-06-19T22:26:54+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.



[644][2018-06-19T22:26:57+02:00] INFO:  
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
user----------
[644][2018-06-19T22:26:57+02:00] INFO: ----------SYNC request received  
for user user
[644][2018-06-19T22:26:57+02:00] INFO: ----------Request being handled  
for device: 4E696E65454141433943383442353944, Supporting protocol  
version: 14.1, Using Horde_ActiveSync v2.39.3
[644][2018-06-19T22:26:57+02:00] INFO: Policykey: 1923231817 verified.
[644][2018-06-19T22:26:57+02:00] I: <Synchronize>
[644][2018-06-19T22:26:57+02:00] I:  <Folders>
[644][2018-06-19T22:26:57+02:00] I:   <Folder>
[644][2018-06-19T22:26:57+02:00] I:    <SyncKey>
[644][2018-06-19T22:26:57+02:00] I:       
{5b2945dc-536c-4021-8792-3ae50a001807}486
[644][2018-06-19T22:26:57+02:00] I:    </SyncKey>
[644][2018-06-19T22:26:57+02:00] I:    <FolderId>
[644][2018-06-19T22:26:57+02:00] I:      A8833469a
[644][2018-06-19T22:26:57+02:00] I:    </FolderId>
[644][2018-06-19T22:26:57+02:00] I:    <DeletesAsMoves>
[644][2018-06-19T22:26:57+02:00] I:      1
[644][2018-06-19T22:26:57+02:00] I:    </DeletesAsMoves>
[644][2018-06-19T22:26:57+02:00] I:    <GetChanges>
[644][2018-06-19T22:26:57+02:00] I:      1
[644][2018-06-19T22:26:57+02:00] I:    </GetChanges>
[644][2018-06-19T22:26:57+02:00] I:    <WindowSize>
[644][2018-06-19T22:26:57+02:00] I:      8
[644][2018-06-19T22:26:57+02:00] I:    </WindowSize>
[644][2018-06-19T22:26:57+02:00] I:    <Options>
[644][2018-06-19T22:26:57+02:00] I:     <FilterType>
[644][2018-06-19T22:26:57+02:00] I:       0
[644][2018-06-19T22:26:57+02:00] I:     </FilterType>
[644][2018-06-19T22:26:57+02:00] I:     <Conflict>
[644][2018-06-19T22:26:57+02:00] I:       1
[644][2018-06-19T22:26:57+02:00] I:     </Conflict>
[644][2018-06-19T22:26:57+02:00] I:     <AirSyncBase:BodyPreference>
[644][2018-06-19T22:26:57+02:00] I:      <AirSyncBase:Type>
[644][2018-06-19T22:26:57+02:00] I:        1
[644][2018-06-19T22:26:57+02:00] I:      </AirSyncBase:Type>
[644][2018-06-19T22:26:57+02:00] I:      <AirSyncBase:TruncationSize>
[644][2018-06-19T22:26:57+02:00] I:        20480
[644][2018-06-19T22:26:57+02:00] I:      </AirSyncBase:TruncationSize>
[644][2018-06-19T22:26:57+02:00] I:      <AirSyncBase:AllOrNone>
[644][2018-06-19T22:26:57+02:00] I:        0
[644][2018-06-19T22:26:57+02:00] I:      </AirSyncBase:AllOrNone>
[644][2018-06-19T22:26:57+02:00] I:     </AirSyncBase:BodyPreference>
[644][2018-06-19T22:26:57+02:00] I:    </Options>
[644][2018-06-19T22:26:57+02:00] I:    <Commands>
[644][2018-06-19T22:26:57+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[644][2018-06-19T22:26:57+02:00] I:     <Add>
[644][2018-06-19T22:26:57+02:00] I:      <ClientEntryId>
[644][2018-06-19T22:26:57+02:00] I:         
4a52af9d-56fc-44e2-a744-dd72f0c1a074
[644][2018-06-19T22:26:57+02:00] I:      </ClientEntryId>
[644][2018-06-19T22:26:57+02:00] I:      <Data>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Timezone>
[644][2018-06-19T22:26:57+02:00] I:         [232 bytes of content]
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:Timezone>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:DtStamp>
[644][2018-06-19T22:26:57+02:00] I:         20180619T202704Z
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:DtStamp>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:StartTime>
[644][2018-06-19T22:26:57+02:00] I:         20180619T160000Z
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:StartTime>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Subject>
[644][2018-06-19T22:26:57+02:00] I:         Tztz
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:Subject>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:UID>
[644][2018-06-19T22:26:57+02:00] I:          
4a52af9d-56fc-44e2-a744-dd72f0c1a074
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:UID>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:OrganizerEmail>
[644][2018-06-19T22:26:57+02:00] I:         user at mauser.info
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:OrganizerEmail>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Location>
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:Location>
[644][2018-06-19T22:26:57+02:00] NOTICE: Unable to get expected  
content for POOMCAL:Location: Setting to an empty string.
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:EndTime>
[644][2018-06-19T22:26:57+02:00] I:         20180619T170000Z
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:EndTime>
[644][2018-06-19T22:26:57+02:00] I:       <AirSyncBase:Body>
[644][2018-06-19T22:26:57+02:00] I:        <AirSyncBase:Type>
[644][2018-06-19T22:26:57+02:00] I:          1
[644][2018-06-19T22:26:57+02:00] I:        </AirSyncBase:Type>
[644][2018-06-19T22:26:57+02:00] I:        <AirSyncBase:Data>
[644][2018-06-19T22:26:57+02:00] I:
[644][2018-06-19T22:26:57+02:00] I:        </AirSyncBase:Data>
[644][2018-06-19T22:26:57+02:00] I:       </AirSyncBase:Body>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Categories />
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Sensitivity>
[644][2018-06-19T22:26:57+02:00] I:         0
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:Sensitivity>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:BusyStatus>
[644][2018-06-19T22:26:57+02:00] I:         2
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:BusyStatus>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:AllDayEvent>
[644][2018-06-19T22:26:57+02:00] I:         0
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:AllDayEvent>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:Reminder>
[644][2018-06-19T22:26:57+02:00] I:         10
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:Reminder>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:MeetingStatus>
[644][2018-06-19T22:26:57+02:00] I:         0
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:MeetingStatus>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:DisallowNewTimeProposal>
[644][2018-06-19T22:26:57+02:00] I:         0
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:DisallowNewTimeProposal>
[644][2018-06-19T22:26:57+02:00] I:       <POOMCAL:ResponseRequested>
[644][2018-06-19T22:26:57+02:00] I:         1
[644][2018-06-19T22:26:57+02:00] I:       </POOMCAL:ResponseRequested>
[644][2018-06-19T22:26:57+02:00] I:      </Data>
[644][2018-06-19T22:26:58+02:00] I:     </Add>
[644][2018-06-19T22:26:58+02:00] I:     <Remove>
[644][2018-06-19T22:26:58+02:00] I:      <ServerEntryId>
[644][2018-06-19T22:26:58+02:00] I:        [55 bytes of content]
[644][2018-06-19T22:26:58+02:00] I:      </ServerEntryId>
[644][2018-06-19T22:26:58+02:00] I:     </Remove>
[644][2018-06-19T22:26:58+02:00] I:    </Commands>
[644][2018-06-19T22:26:58+02:00] ERR:  
20180619205015.ujdHY4ij8KaR75UNokcJcIL at post.mauser.info not found
[644][2018-06-19T22:26:58+02:00] INFO: Processed 2 incoming changes
[644][2018-06-19T22:26:58+02:00] I:   </Folder>
[644][2018-06-19T22:26:58+02:00] I:  </Folders>
[644][2018-06-19T22:26:58+02:00] I: </Synchronize>
[644][2018-06-19T22:26:58+02:00] INFO: Completed parsing incoming  
request. Peak memory usage: 6291456.
[644][2018-06-19T22:26:58+02:00] O: <Synchronize>
[644][2018-06-19T22:26:58+02:00] O:  <Status>
[644][2018-06-19T22:26:58+02:00] O:   1
[644][2018-06-19T22:26:58+02:00] O:  </Status>
[644][2018-06-19T22:26:58+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[644][2018-06-19T22:26:58+02:00] ERR: Permission Denied
[1075][2018-06-19T22:26:59+02:00] INFO:  
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
user----------
[1075][2018-06-19T22:26:59+02:00] INFO: ----------SYNC request  
received for user user
[1075][2018-06-19T22:26:59+02:00] INFO: ----------Request being  
handled for device: 4E696E65454141433943383442353944, Supporting  
protocol version: 14.1, Using Horde_ActiveSync v2.39.3
[1075][2018-06-19T22:26:59+02:00] INFO: Policykey: 1923231817 verified.
[1075][2018-06-19T22:26:59+02:00] I: <Synchronize>
[1075][2018-06-19T22:26:59+02:00] I:  <Folders>
[1075][2018-06-19T22:26:59+02:00] I:   <Folder>
[1075][2018-06-19T22:26:59+02:00] I:    <SyncKey>
[1075][2018-06-19T22:26:59+02:00] I:       
{5b2945dc-536c-4021-8792-3ae50a001807}486
[1075][2018-06-19T22:26:59+02:00] I:    </SyncKey>
[1075][2018-06-19T22:26:59+02:00] I:    <FolderId>
[1075][2018-06-19T22:26:59+02:00] I:      A8833469a
[1075][2018-06-19T22:26:59+02:00] I:    </FolderId>
[1075][2018-06-19T22:26:59+02:00] I:    <DeletesAsMoves>
[1075][2018-06-19T22:26:59+02:00] I:      1
[1075][2018-06-19T22:26:59+02:00] I:    </DeletesAsMoves>
[1075][2018-06-19T22:26:59+02:00] I:    <GetChanges>
[1075][2018-06-19T22:26:59+02:00] I:      1
[1075][2018-06-19T22:26:59+02:00] I:    </GetChanges>
[1075][2018-06-19T22:26:59+02:00] I:    <WindowSize>
[1075][2018-06-19T22:26:59+02:00] I:      8
[1075][2018-06-19T22:26:59+02:00] I:    </WindowSize>
[1075][2018-06-19T22:26:59+02:00] I:    <Options>
[1075][2018-06-19T22:26:59+02:00] I:     <FilterType>
[1075][2018-06-19T22:26:59+02:00] I:       0
[1075][2018-06-19T22:26:59+02:00] I:     </FilterType>
[1075][2018-06-19T22:26:59+02:00] I:     <Conflict>
[1075][2018-06-19T22:26:59+02:00] I:       1
[1075][2018-06-19T22:26:59+02:00] I:     </Conflict>
[1075][2018-06-19T22:26:59+02:00] I:     <AirSyncBase:BodyPreference>
[1075][2018-06-19T22:26:59+02:00] I:      <AirSyncBase:Type>
[1075][2018-06-19T22:26:59+02:00] I:        1
[1075][2018-06-19T22:26:59+02:00] I:      </AirSyncBase:Type>
[1075][2018-06-19T22:26:59+02:00] I:      <AirSyncBase:TruncationSize>
[1075][2018-06-19T22:26:59+02:00] I:        20480
[1075][2018-06-19T22:26:59+02:00] I:      </AirSyncBase:TruncationSize>
[1075][2018-06-19T22:26:59+02:00] I:      <AirSyncBase:AllOrNone>
[1075][2018-06-19T22:26:59+02:00] I:        0
[1075][2018-06-19T22:26:59+02:00] I:      </AirSyncBase:AllOrNone>
[1075][2018-06-19T22:26:59+02:00] I:     </AirSyncBase:BodyPreference>
[1075][2018-06-19T22:26:59+02:00] I:    </Options>
[1075][2018-06-19T22:26:59+02:00] I:    <Commands>
[1075][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing  
state for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[1075][2018-06-19T22:26:59+02:00] I:     <Add>
[1075][2018-06-19T22:26:59+02:00] I:      <ClientEntryId>
[1075][2018-06-19T22:26:59+02:00] I:         
4a52af9d-56fc-44e2-a744-dd72f0c1a074
[1075][2018-06-19T22:26:59+02:00] I:      </ClientEntryId>
[1075][2018-06-19T22:26:59+02:00] I:      <Data>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Timezone>
[1075][2018-06-19T22:26:59+02:00] I:         [232 bytes of content]
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:Timezone>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:DtStamp>
[1075][2018-06-19T22:26:59+02:00] I:         20180619T202705Z
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:DtStamp>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:StartTime>
[1075][2018-06-19T22:26:59+02:00] I:         20180619T160000Z
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:StartTime>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Subject>
[1075][2018-06-19T22:26:59+02:00] I:         Tztz
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:Subject>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:UID>
[1075][2018-06-19T22:26:59+02:00] I:          
4a52af9d-56fc-44e2-a744-dd72f0c1a074
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:UID>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:OrganizerEmail>
[1075][2018-06-19T22:26:59+02:00] I:         user at mauser.info
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:OrganizerEmail>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Location>
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:Location>
[1075][2018-06-19T22:26:59+02:00] NOTICE: Unable to get expected  
content for POOMCAL:Location: Setting to an empty string.
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:EndTime>
[1075][2018-06-19T22:26:59+02:00] I:         20180619T170000Z
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:EndTime>
[1075][2018-06-19T22:26:59+02:00] I:       <AirSyncBase:Body>
[1075][2018-06-19T22:26:59+02:00] I:        <AirSyncBase:Type>
[1075][2018-06-19T22:26:59+02:00] I:          1
[1075][2018-06-19T22:26:59+02:00] I:        </AirSyncBase:Type>
[1075][2018-06-19T22:26:59+02:00] I:        <AirSyncBase:Data>
[1075][2018-06-19T22:26:59+02:00] I:
[1075][2018-06-19T22:26:59+02:00] I:        </AirSyncBase:Data>
[1075][2018-06-19T22:26:59+02:00] I:       </AirSyncBase:Body>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Categories />
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Sensitivity>
[1075][2018-06-19T22:26:59+02:00] I:         0
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:Sensitivity>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:BusyStatus>
[1075][2018-06-19T22:26:59+02:00] I:         2
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:BusyStatus>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:AllDayEvent>
[1075][2018-06-19T22:26:59+02:00] I:         0
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:AllDayEvent>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:Reminder>
[1075][2018-06-19T22:26:59+02:00] I:         10
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:Reminder>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:MeetingStatus>
[1075][2018-06-19T22:26:59+02:00] I:         0
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:MeetingStatus>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:DisallowNewTimeProposal>
[1075][2018-06-19T22:26:59+02:00] I:         0
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:DisallowNewTimeProposal>
[1075][2018-06-19T22:26:59+02:00] I:       <POOMCAL:ResponseRequested>
[1075][2018-06-19T22:26:59+02:00] I:         1
[1075][2018-06-19T22:26:59+02:00] I:       </POOMCAL:ResponseRequested>
[1075][2018-06-19T22:26:59+02:00] I:      </Data>
[1075][2018-06-19T22:26:59+02:00] NOTICE: Duplicate addition for  
20180619222658.h8z6nRIUqX0TOAjlt5QcrVB at post.mauser.info
[1075][2018-06-19T22:26:59+02:00] I:     </Add>
[1075][2018-06-19T22:26:59+02:00] I:     <Remove>
[1075][2018-06-19T22:26:59+02:00] I:      <ServerEntryId>
[1075][2018-06-19T22:26:59+02:00] I:        [55 bytes of content]
[1075][2018-06-19T22:26:59+02:00] I:      </ServerEntryId>
[1075][2018-06-19T22:26:59+02:00] I:     </Remove>
[1075][2018-06-19T22:26:59+02:00] I:    </Commands>
[1075][2018-06-19T22:26:59+02:00] ERR:  
20180619205015.ujdHY4ij8KaR75UNokcJcIL at post.mauser.info not found
[1075][2018-06-19T22:26:59+02:00] INFO: Processed 2 incoming changes
[1075][2018-06-19T22:26:59+02:00] I:   </Folder>
[1075][2018-06-19T22:26:59+02:00] I:  </Folders>
[1075][2018-06-19T22:26:59+02:00] I: </Synchronize>
[1075][2018-06-19T22:26:59+02:00] INFO: Completed parsing incoming  
request. Peak memory usage: 4194304.
[1075][2018-06-19T22:26:59+02:00] O: <Synchronize>
[1075][2018-06-19T22:26:59+02:00] O:  <Status>
[1075][2018-06-19T22:26:59+02:00] O:   1
[1075][2018-06-19T22:26:59+02:00] O:  </Status>
[1075][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing  
state for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[1075][2018-06-19T22:26:59+02:00] ERR: Permission Denied
[655][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[655][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[655][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[655][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[655][2018-06-19T22:26:59+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[655][2018-06-19T22:26:59+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[666][2018-06-19T22:27:04+02:00] INFO:  
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
user----------
[666][2018-06-19T22:27:04+02:00] INFO: ----------PING request received  
for user user
[666][2018-06-19T22:27:04+02:00] INFO: ----------Request being handled  
for device: 4E696E65454141433943383442353944, Supporting protocol  
version: 14.1, Using Horde_ActiveSync v2.39.3
[666][2018-06-19T22:27:04+02:00] I: <Ping:Ping>
[666][2018-06-19T22:27:04+02:00] I:  <Ping:HeartbeatInterval>
[666][2018-06-19T22:27:04+02:00] I:    900
[666][2018-06-19T22:27:04+02:00] I:  </Ping:HeartbeatInterval>
[666][2018-06-19T22:27:04+02:00] I:  <Ping:Folders>
[666][2018-06-19T22:27:04+02:00] I:   <Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:      T01e5245c
[666][2018-06-19T22:27:04+02:00] I:    </Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:      Tasks
[666][2018-06-19T22:27:04+02:00] I:    </Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:   </Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:   <Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:      Naf79c7b8
[666][2018-06-19T22:27:04+02:00] I:    </Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:      Notes
[666][2018-06-19T22:27:04+02:00] I:    </Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:   </Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:   <Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:      Fea73919c
[666][2018-06-19T22:27:04+02:00] I:    </Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:      Email
[666][2018-06-19T22:27:04+02:00] I:    </Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:   </Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:   <Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:      F66415995
[666][2018-06-19T22:27:04+02:00] I:    </Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:      Email
[666][2018-06-19T22:27:04+02:00] I:    </Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:   </Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:   <Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:      C8c785b89
[666][2018-06-19T22:27:04+02:00] I:    </Ping:ServerEntryId>
[666][2018-06-19T22:27:04+02:00] I:    <Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:      Contacts
[666][2018-06-19T22:27:04+02:00] I:    </Ping:FolderType>
[666][2018-06-19T22:27:04+02:00] I:   </Ping:Folder>
[666][2018-06-19T22:27:04+02:00] I:  </Ping:Folders>
[666][2018-06-19T22:27:04+02:00] I: </Ping:Ping>
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Waiting for  
changes for 900 seconds
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:04+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:04+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[655][2018-06-19T22:27:04+02:00] INFO: Changes in cache detected  
during PING, exiting here.
[655][2018-06-19T22:27:04+02:00] INFO: Maximum memory usage for  
ActiveSync request: 2097152 bytes.

[666][2018-06-19T22:27:09+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:09+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:09+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:09+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:09+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:09+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[666][2018-06-19T22:27:14+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:14+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:14+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:14+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:14+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:14+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.


[666][2018-06-19T22:27:19+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:19+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:19+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:19+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:19+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:19+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.

[666][2018-06-19T22:27:24+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:24+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:24+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:24+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:24+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:24+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.



[666][2018-06-19T22:27:29+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:29+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:29+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:29+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:29+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:29+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[666][2018-06-19T22:27:34+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:34+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:34+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:34+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:34+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:34+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[708][2018-06-19T22:27:35+02:00] INFO:  
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
user----------
[708][2018-06-19T22:27:35+02:00] INFO: ----------SYNC request received  
for user user
[708][2018-06-19T22:27:35+02:00] INFO: ----------Request being handled  
for device: 4E696E65454141433943383442353944, Supporting protocol  
version: 14.1, Using Horde_ActiveSync v2.39.3
[708][2018-06-19T22:27:35+02:00] INFO: Policykey: 1923231817 verified.
[708][2018-06-19T22:27:35+02:00] I: <Synchronize>
[708][2018-06-19T22:27:35+02:00] I:  <Folders>
[708][2018-06-19T22:27:35+02:00] I:   <Folder>
[708][2018-06-19T22:27:35+02:00] I:    <SyncKey>
[708][2018-06-19T22:27:35+02:00] I:       
{5b2945dc-536c-4021-8792-3ae50a001807}486
[708][2018-06-19T22:27:35+02:00] I:    </SyncKey>
[708][2018-06-19T22:27:35+02:00] I:    <FolderId>
[708][2018-06-19T22:27:35+02:00] I:      A8833469a
[708][2018-06-19T22:27:35+02:00] I:    </FolderId>
[708][2018-06-19T22:27:35+02:00] I:    <DeletesAsMoves>
[708][2018-06-19T22:27:35+02:00] I:      1
[708][2018-06-19T22:27:35+02:00] I:    </DeletesAsMoves>
[708][2018-06-19T22:27:35+02:00] I:    <GetChanges>
[708][2018-06-19T22:27:35+02:00] I:      1
[708][2018-06-19T22:27:35+02:00] I:    </GetChanges>
[708][2018-06-19T22:27:35+02:00] I:    <WindowSize>
[708][2018-06-19T22:27:35+02:00] I:      8
[708][2018-06-19T22:27:35+02:00] I:    </WindowSize>
[708][2018-06-19T22:27:35+02:00] I:    <Options>
[708][2018-06-19T22:27:35+02:00] I:     <FilterType>
[708][2018-06-19T22:27:35+02:00] I:       0
[708][2018-06-19T22:27:35+02:00] I:     </FilterType>
[708][2018-06-19T22:27:35+02:00] I:     <Conflict>
[708][2018-06-19T22:27:35+02:00] I:       1
[708][2018-06-19T22:27:35+02:00] I:     </Conflict>
[708][2018-06-19T22:27:35+02:00] I:     <AirSyncBase:BodyPreference>
[708][2018-06-19T22:27:35+02:00] I:      <AirSyncBase:Type>
[708][2018-06-19T22:27:35+02:00] I:        1
[708][2018-06-19T22:27:35+02:00] I:      </AirSyncBase:Type>
[708][2018-06-19T22:27:35+02:00] I:      <AirSyncBase:TruncationSize>
[708][2018-06-19T22:27:35+02:00] I:        20480
[708][2018-06-19T22:27:35+02:00] I:      </AirSyncBase:TruncationSize>
[708][2018-06-19T22:27:35+02:00] I:      <AirSyncBase:AllOrNone>
[708][2018-06-19T22:27:35+02:00] I:        0
[708][2018-06-19T22:27:35+02:00] I:      </AirSyncBase:AllOrNone>
[708][2018-06-19T22:27:35+02:00] I:     </AirSyncBase:BodyPreference>
[708][2018-06-19T22:27:35+02:00] I:    </Options>
[708][2018-06-19T22:27:35+02:00] I:    <Commands>
[708][2018-06-19T22:27:35+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[708][2018-06-19T22:27:35+02:00] I:     <Remove>
[708][2018-06-19T22:27:35+02:00] I:      <ServerEntryId>
[708][2018-06-19T22:27:35+02:00] I:        [55 bytes of content]
[708][2018-06-19T22:27:35+02:00] I:      </ServerEntryId>
[708][2018-06-19T22:27:35+02:00] I:     </Remove>
[708][2018-06-19T22:27:35+02:00] I:    </Commands>
[708][2018-06-19T22:27:35+02:00] ERR:  
20180619205015.ujdHY4ij8KaR75UNokcJcIL at post.mauser.info not found
[708][2018-06-19T22:27:35+02:00] INFO: Processed 1 incoming changes
[708][2018-06-19T22:27:35+02:00] I:   </Folder>
[708][2018-06-19T22:27:35+02:00] I:  </Folders>
[708][2018-06-19T22:27:35+02:00] I: </Synchronize>
[708][2018-06-19T22:27:35+02:00] INFO: Completed parsing incoming  
request. Peak memory usage: 2097152.
[708][2018-06-19T22:27:35+02:00] O: <Synchronize>
[708][2018-06-19T22:27:35+02:00] O:  <Status>
[708][2018-06-19T22:27:35+02:00] O:   1
[708][2018-06-19T22:27:35+02:00] O:  </Status>
[708][2018-06-19T22:27:35+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Calendar@, synckey:  
{5b2945dc-536c-4021-8792-3ae50a001807}486
[708][2018-06-19T22:27:35+02:00] ERR: Permission Denied
[666][2018-06-19T22:27:39+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[666][2018-06-19T22:27:39+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[666][2018-06-19T22:27:39+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[666][2018-06-19T22:27:39+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[666][2018-06-19T22:27:39+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[666][2018-06-19T22:27:39+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[644][2018-06-19T22:27:40+02:00] INFO:  
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
user----------
[644][2018-06-19T22:27:40+02:00] INFO: ----------PING request received  
for user user
[644][2018-06-19T22:27:40+02:00] INFO: ----------Request being handled  
for device: 4E696E65454141433943383442353944, Supporting protocol  
version: 14.1, Using Horde_ActiveSync v2.39.3
[644][2018-06-19T22:27:40+02:00] I: <Ping:Ping>
[644][2018-06-19T22:27:40+02:00] I:  <Ping:HeartbeatInterval>
[644][2018-06-19T22:27:40+02:00] I:    900
[644][2018-06-19T22:27:40+02:00] I:  </Ping:HeartbeatInterval>
[644][2018-06-19T22:27:40+02:00] I:  <Ping:Folders>
[644][2018-06-19T22:27:40+02:00] I:   <Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:      T01e5245c
[644][2018-06-19T22:27:40+02:00] I:    </Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:      Tasks
[644][2018-06-19T22:27:40+02:00] I:    </Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:   </Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:   <Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:      Naf79c7b8
[644][2018-06-19T22:27:40+02:00] I:    </Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:      Notes
[644][2018-06-19T22:27:40+02:00] I:    </Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:   </Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:   <Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:      Fea73919c
[644][2018-06-19T22:27:40+02:00] I:    </Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:      Email
[644][2018-06-19T22:27:40+02:00] I:    </Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:   </Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:   <Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:      F66415995
[644][2018-06-19T22:27:40+02:00] I:    </Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:      Email
[644][2018-06-19T22:27:40+02:00] I:    </Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:   </Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:   <Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:      C8c785b89
[644][2018-06-19T22:27:40+02:00] I:    </Ping:ServerEntryId>
[644][2018-06-19T22:27:40+02:00] I:    <Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:      Contacts
[644][2018-06-19T22:27:40+02:00] I:    </Ping:FolderType>
[644][2018-06-19T22:27:40+02:00] I:   </Ping:Folder>
[644][2018-06-19T22:27:40+02:00] I:  </Ping:Folders>
[644][2018-06-19T22:27:40+02:00] I: </Ping:Ping>
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Waiting for  
changes for 900 seconds
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Tasks@, synckey:  
{5b29286a-5998-4b67-947c-34d00a001807}45
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Notes@, synckey:  
{5b29286b-1e24-4b7c-9814-34b30a001807}2
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Initializing state  
for collection: Sent, synckey: {5b29286b-4128-448b-9135-34d50a001807}2
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Initializing state  
for collection: INBOX, synckey: {5b29286c-1908-4309-b6a2-352d0a001807}2
[644][2018-06-19T22:27:40+02:00] INFO: COLLECTIONS: Initializing state  
for collection: @Contacts@, synckey:  
{5b29286d-fde0-4d98-861c-34c60a001807}31
[644][2018-06-19T22:27:40+02:00] INFO: ----------COLLECTIONS: Sleeping  
for 5 seconds.
[666][2018-06-19T22:27:44+02:00] INFO: Changes in cache detected  
during PING, exiting here.
[666][2018-06-19T22:27:44+02:00] INFO: Maximum memory usage for  
ActiveSync request: 4194304 bytes.

I see the 'ERR: Permission Denied', but not what's been denied.

Best regards,
Andreas


-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-keys
Size: 3871 bytes
Desc: ?ffentlicher PGP-Schl?ssel
URL: <https://lists.horde.org/archives/horde/attachments/20180619/b5bd9ef3/attachment-0001.bin>


More information about the horde mailing list