[horde] Horde 5.1 Activesync does not work with Windows Phone 7.8

Wed Jun 19 16:42:38 UTC 2013

Quoting Mail Admin <pinemail11 at gmail.com>> Thanks Arjen & Mike, I am  
able to capture the logs.
>
>  Here are the logs
>
>  Regards,
>
>  Pine
>
>  Either this isn't the entire log or something is really screwed up with
> your system.
>
> Mike
>
> Hummmm..
>
> I am not aware of what I screwed but I tested Active Sync for Android 2.3,
> 4.1 devices & Outlook 2013 and everything is working fine.
>
> also there are two files getting generated with the same name for WP with
> the difference in case
>
> 0f6e4c41f36aea536bca5c90000f94ae.txt
>
> &
>
> 0F6E4C41F36AEA536BCA5C90000F94AE.txt
>
>
> & here are the logs of both the files
>
>
> [root at cm14a sync]# vim 0f6e4c41f36aea536bca5c90000f94ae.txt
>
> 2013-06-19T00:58:04+00:00 INFO: [22103]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T00:58:04+00:00 DEBUG: [22103] FOLDERSYNC request received for
> user user1 at domain.com
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Request being handled for device:
> 0F6E4C41F36AEA536BCA5C90000F94AE Supporting protocol version: 14.1
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Handling FOLDERSYNC command.
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Checking policykey for device:
> 0F6E4C41F36AEA536BCA5C90000F94AE user: user1 at domain.com
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Policykey: 0 verified.
>
> 2013-06-19T00:58:04+00:00 DEBUG: [22103] I  <FolderHierarchy:FolderSync>
>
> 2013-06-19T00:58:04+00:00 DEBUG: [22103] I   <FolderHierarchy:SyncKey>
>
> 2013-06-19T00:58:04+00:00 DEBUG: [22103] I     0
>
> 2013-06-19T00:58:04+00:00 DEBUG: [22103] I   </FolderHierarchy:SyncKey>
>
> 2013-06-19T00:58:04+00:00 NOTICE: [22103]
> Horde_ActiveSync_State_Sql::loadState: clearing folder state.
>
> 2013-06-19T00:58:04+00:00 INFO: [22103] Resetting device state for device:
> 0F6E4C41F36AEA536BCA5C90000F94AE, user: user1 at domain.com, and collection:
> foldersync.
>
> 2013-06-19T00:58:06+00:00 NOTICE: [22103] Clearing foldersync state from
> synccache.
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Replacing SYNC_CACHE entry for user
> user1 at domain.com and device 0F6E4C41F36AEA536BCA5C90000F94AE:
> a:11:{s:18:"confirmed_synckeys";a:0:{}s:17:"lasthbsyncstarted";b:0;s:17:"lastsyncendnormal";b:0;s:9:"timestamp";s:10:"1371603486";s:4:"wait";b:0;s:10:"hbinterval";b:0;s:7:"folders";a:0:{}s:9:"hierarchy";s:1:"0";s:11:"collections";a:0:{}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}}
>
> 2013-06-19T00:58:06+00:00 DEBUG: [22103] I  </FolderHierarchy:FolderSync>
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Initializing folder diff engine
>
> 2013-06-19T00:58:06+00:00 INFO: [22103]
> Horde_Core_ActiveSync_Driver::getFolderList()
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Polling
> Horde_Core_ActiveSync_Driver::_getMailFolders()
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] No folderid found for INBOX
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Creating new folder uuid for INBOX:
> 782f3da7
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] No folderid found for Drafts
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Creating new folder uuid for
> Drafts: 5e017d0c
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] No folderid found for Junk
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Creating new folder uuid for Junk:
> 49f7864e
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] No folderid found for Sent
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Creating new folder uuid for Sent:
> e9dc1b8b
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] No folderid found for Trash
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Creating new folder uuid for Trash:
> f2b76ad7
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Found 9 folder changes.
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 INFO: [22103] Updating state during foldersync
>
> 2013-06-19T00:58:06+00:00 DEBUG: [22103] O  <FolderHierarchy:FolderSync>
>
> 2013-06-19T00:58:06+00:00 DEBUG: [22103] O   <FolderHierarchy:Status>
>
> "0f6e4c41f36aea536bca5c90000f94ae.txt" 1365L, 109298C
>
> --------------------------------------------------------------------------------------------------------------------------------
>
> [root at cm14a sync]# vim 0F6E4C41F36AEA536BCA5C90000F94AE.txt
>
> 2013-06-19T00:58:03+00:00 INFO: [22164]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T00:58:03+00:00 DEBUG: [22164] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T00:58:04+00:00 INFO: [22164] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T00:58:04+00:00 INFO: [22164] User user1 at domain.com logged off
>
> 2013-06-19T00:58:10+00:00 INFO: [22102]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T00:58:10+00:00 DEBUG: [22102] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T00:58:10+00:00 INFO: [22102] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T00:58:11+00:00 INFO: [22102] User user1 at domain.com logged off
>
> 2013-06-19T00:59:16+00:00 INFO: [22097]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T00:59:16+00:00 DEBUG: [22097] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T00:59:16+00:00 INFO: [22097] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T00:59:16+00:00 INFO: [22097] User user1 at domain.com logged off
>
> 2013-06-19T00:59:38+00:00 INFO: [22096]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T00:59:38+00:00 DEBUG: [22096] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T00:59:38+00:00 INFO: [22096] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T00:59:38+00:00 INFO: [22096] User user1 at domain.com logged off
>
> 2013-06-19T01:01:11+00:00 INFO: [22102]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T01:01:11+00:00 DEBUG: [22102] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T01:01:11+00:00 INFO: [22102] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T01:01:11+00:00 INFO: [22102] User user1 at domain.com logged off
>
> 2013-06-19T01:06:46+00:00 INFO: [22098]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T01:07:28+00:00 INFO: [22097]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T01:07:28+00:00 DEBUG: [22097] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T01:07:28+00:00 INFO: [22097] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T01:07:28+00:00 INFO: [22097] User user1 at domain.com logged off
>
> 2013-06-19T01:07:29+00:00 INFO: [22099]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T01:07:29+00:00 DEBUG: [22099] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T01:07:29+00:00 INFO: [22099] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T01:07:29+00:00 INFO: [22099] User user1 at domain.com logged off
>
> 2013-06-19T01:09:50+00:00 INFO: [22099]
> Horde_Core_ActiveSync_Driver::authenticate() attempt for user1 at domain.com
>
> 2013-06-19T01:09:50+00:00 DEBUG: [22099] OPTIONS request received for user
> user1 at domain.com
>
> 2013-06-19T01:09:50+00:00 INFO: [22099] Device entry exists for
> 0F6E4C41F36AEA536BCA5C90000F94AE, updating userAgent and version.
>
> 2013-06-19T01:09:50+00:00 INFO: [22099] User user1 at domain.com logged off
>
>
> Any help is appreciated!!
>
> Regards,
>
> Pine.
> --
> Horde mailing list
> Frequently Asked Questions: http://horde.org/faq/
> To unsubscribe, mail: horde-unsubscribe at lists.horde.org
>
Please attach the *full* logs,  not a copy/paste of the first page  
displayed in vim.

Also,  are you sure you have every thing up to date?  I'm almost  
positive the lower/upper case log issue was already fixed.

mike
Sent from mobile

Mail Admin <pinemail11 at gmail.com> wrote: