Summary | ActiveSync only works in initial configuration |
Queue | Synchronization |
Queue Version | FRAMEWORK_5_2 |
Type | Bug |
State | Not Reproducible |
Priority | 1. Low |
Owners | mrubinsk (at) horde (dot) org |
Requester | forum (at) graf-online (dot) me |
Created | 12/06/2021 (1366 days ago) |
Due | |
Updated | 02/13/2022 (1297 days ago) |
Assigned | 12/13/2021 (1359 days ago) |
Resolved | 02/13/2022 (1297 days ago) |
Github Issue Link | |
Github Pull Request | |
Milestone | |
Patch | No |
[8391][2022-01-23T07:39:48+00:00] NOTICE: STATE: Error saving state,
checking if this is due to previous synckey
{61ed0020-a9b8-4f22-a59c-20c59f45fb64}10 not being accepted by client.
preventing the client from receiving the full response from the
server, which is probably the cause of this issue. I would double
check the user's permissions to the Horde application, the Kronolith
application. as well as all the calendars that are being requested.
to the client that it does not recognize or understand so it sends the
previous synckey back again to the server when asking for changes. I
can also be due to the client not receiving the response due to some
networking issue.
requested in the sync? Not just permissions to the application, but to
each calendar. Sometimes this error is due to a stale preference in
Horde indicating which calendars to sync. You can try visiting the
sync preferences for kronolith and resetting/resaving the value for
which calendars to synchronize.
New Attachment: log.zip
However I still have sync issues :-(
What I have done:
1. Added permissions in horde-->permissions to access horde application
2. Remove the device from activesync configuration
3. deleted the .ost file from outlook to restart initialization, due
to sync-id issues referred to in the logs
After reinitializing everything Outlook started to download all the
messages in all folders - that worked perfectly :)
Then I sent a test message to my mailbox and hoped that it'll sync
also - but it didn't.
Skimming through the logs I found two issues:
########################################################################################
[8391][2022-01-23T07:39:48+00:00] NOTICE: STATE: Error saving state,
checking if this is due to previous synckey
{61ed0020-a9b8-4f22-a59c-20c59f45fb64}10 not being accepted by client.
[8391][2022-01-23T07:39:48+00:00] O: </Folder>
[8391][2022-01-23T07:39:48+00:00] >>>: Collection output peak memory
usage: 2097152
[8391][2022-01-23T07:39:48+00:00] INFO: COLLECTIONS: Initializing
state for collection: @Calendar@, synckey:
{61ed0020-1d04-43e2-b600-20c59f45fb64}2
[8391][2022-01-23T07:39:48+00:00] >>>: STATE: Loading state for
synckey {61ed0020-1d04-43e2-b600-20c59f45fb64}2
[8391][2022-01-23T07:39:48+00:00] >>>: STATE: Initializing message
diff engine for A00722152 (@Calendar@)
[8391][2022-01-23T07:39:48+00:00] >>>:
Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 1259);
[8391][2022-01-23T08:39:48+01:00] >>>: STATE: Using SYNCSTAMP 1259 for
A00722152.
[8391][2022-01-23T08:39:48+01:00] >>>:
Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 1259, 1259,
0, 0, 1, 100, )
[8391][2022-01-23T08:39:48+01:00] >>>: Fetching changes for calendar
using MODSEQ.
[8391][2022-01-23T08:39:48+01:00] >>>: Polling for SOFTDELETE items in
calendar collection
[8391][2022-01-23T08:39:48+01:00] ERR: Permission Denied
[8389][2022-01-23T07:39:48+00:00] INFO:
----------Horde_Core_ActiveSync_Driver::authenticate() attempt for
Stefan@graf-online.me----------
[8389][2022-01-23T07:39:48+00:00] INFO: ----------PING request
received for user Stefan@graf-online.me
[8389][2022-01-23T07:39:48+00:00] >>>: STATE: Device entry exists for
4C7CB7925B3442B59E878E5CC56280B4, updating userAgent, version, and
supported.
[8389][2022-01-23T07:39:48+00:00] INFO: ----------Request being
handled for device: 4C7CB7925B3442B59E878E5CC56280B4, of type:
WindowsOutlook15, supporting protocol version: 14.0, using
Horde_ActiveSync v2.41.5
###########################################################################################
1. There is an issue with the STATE as it cant be saved due to the client
2. There is a Permission Denied error in the calendar area
I the added permissions for kronolith in the horde
configuration-->permissions section. But this didn't help.
Any suggestions what is missing?
The attached log ist the full log of the sync attempt of outlook -
starting right at the beginning and repeats where it got the issues.
Thanks for your support!
BR
Stefan
Look like there is an authorization issue with my account?
[4319][2021-12-19T09:14:18+00:00] ERR: User Stefan@graf-online.me is
not authorized for Horde (Host: p5b2a4192.dip0.t-ipconnect.de).
indicates that the specified user does not have permissions set for
the "Horde" application in admin->permissions. This is required for
ActiveSync to work.
via the web UI?
New Attachment: 4C7CB7925B3442B59E878E5CC56280B4.txt
Look like there is an authorization issue with my account?
Interestingly - my account works with ActiveSync on my mobile phone.
horde config.
Activesync is configured to log detailed on a per device base.
Unfortunately there are not showing up any logs in the confugred folder.
$conf['activesync']['logging']['path'] and make sure it is writable
by the webserver.
horde config.
Activesync is configured to log detailed on a per device base.
Unfortunately there are not showing up any logs in the confugred folder.
I tried to change the debug level in the horde log to debug but this
changed only the amount of messages in syslog but not giving me any
logfiles for activesync.
any idea to get these log files enabled?
Thanks
Stefan
in the horde config.
Hi,
Right now I have no idea how to get these logs from Outlook but I'll
find out :)
Autodiscover in deet need to work via O365 which actually breaks it.
That makes configuring the profile a bit tricky but there are some
workarounds available.
I can get you the logs over the weekend and upload it here.
Right now I have no idea how to get these logs from Outlook but I'll
find out :)
Autodiscover in deet need to work via O365 which actually breaks it.
That makes configuring the profile a bit tricky but there are some
workarounds available.
Assigned to Michael Rubinsky
State ⇒ Feedback
exhibiting this issue. I CAN tell you that I have pretty much given up
on getting Outlook to work flawlessly with Activesync as Microsoft
seems to continuously change how Outlook behaves with it. I'm
surprised you were able to get that far, to be honest, as last I
checked the autodiscovery process that Outlook now uses requires it to
go through O365.
Patch ⇒ No
State ⇒ Unconfirmed
Milestone ⇒
Queue ⇒ Synchronization
Summary ⇒ ActiveSync only works in initial configuration
Type ⇒ Bug
Priority ⇒ 1. Low
I am running Horde 5.2.22 with ActiveSync enabled.
On a brand new MS Surface (Win 11) with Office 365 (most up to date
Outlook version).
Outlook is configured to sync with Exchange Server and the initial
download of all messages works fine. But after rebooting the machine
Outlook does not fully reconnect to ActiveSync. There is actually no
error message in Outlook - but the status shows that it is connected
to the server and is waiting for his response.
So it look like that the baisc connection is fully working but some
service on the server does not respond propperly and Outlook does not
sync anything.
I can't believe that this is a issue in the connector but most likely
in my configuration. Does anyone have an idea which settings /
configuration I should double check?
Thanks
Stefan