[sync] ActiveSync issues

Mon Aug 12 18:12:00 UTC 2013

Quoting Ivan Kouvykov <ivan at kouvykov.com>:

> The logs were too big and the messages were rejected.
>
>> -----Original Message-----
>> From: sync-bounces at lists.horde.org [mailto:sync-bounces at lists.horde.org]
>> On Behalf Of Michael J Rubinsky
>> Sent: Thursday, August 08, 2013 10:55 PM
>> To: sync at lists.horde.org
>> Subject: Re: [sync] ActiveSync issues
>>
>> Please don't top post.
>>
>> Quoting Ivan Kouvykov <ivan at kouvykov.com>:
>>
>> > Horde main log attached. There are errors there too. Could be relevant
>>
>> I would need the *sync* log to know for sure, but it looks like either you
>> or the client is sending a DELETEFOLDER request before the initial
>> FOLDER_SYNC was done.
>>
>
> Links to sync logs below.

>> >>> 2.  HTC One X only gets e-mails that were created in IMAP server
>> >>> after horde was set up (i.e. new emails arrive, but the old ones are
>> >>> not downloaded)
>> >>
>> >> Would need to see the sync log, but might simply be a filter setting
>> >> on the client.
>> >>
>
> HTC One X log. HTC775b17693f2a82d3f9648b65928a8.zip:  
> https://kouvykov.com:5001/fbsharing/rFT02o6M

Your synclog clearly shows 4 emails being transferred to the client on  
the initial sync. Your device is asking for emails not any older than  
2 weeks:

2013-08-08T20:43:32+04:00 DEBUG: [31529] I  <Synchronize>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I   <Folders>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I    <Folder>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <SyncKey>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I        
{5203caaf-4b30-40de-a5c3-7b290afa0afa}1
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     </SyncKey>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <FolderId>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       fc2c48ea
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     </FolderId>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <DeletesAsMoves>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       1
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     </DeletesAsMoves>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <GetChanges />
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <WindowSize>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       50
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     </WindowSize>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     <Options>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      <FilterType>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I        1
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      </FilterType>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      <AirSyncBase:BodyPreference>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       <AirSyncBase:Type>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I         1
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       </AirSyncBase:Type>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       <AirSyncBase:TruncationSize>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I         5120
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       </AirSyncBase:TruncationSize>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       <AirSyncBase:AllOrNone>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I         0
2013-08-08T20:43:32+04:00 DEBUG: [31529] I       </AirSyncBase:AllOrNone>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      </AirSyncBase:BodyPreference>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      <Conflict>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I        1
2013-08-08T20:43:32+04:00 DEBUG: [31529] I      </Conflict>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I     </Options>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I    </Folder>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I   </Folders>
2013-08-08T20:43:32+04:00 DEBUG: [31529] I  </Synchronize>

2013-08-08T20:43:33+04:00 DEBUG: [31529] O  <Synchronize>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O   <Status>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O    1
2013-08-08T20:43:33+04:00 DEBUG: [31529] O   </Status>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O   <Folders>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O    <Folder>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     <SyncKey>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O       
{5203caaf-4b30-40de-a5c3-7b290afa0afa}2
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     </SyncKey>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     <FolderId>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O      fc2c48ea
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     </FolderId>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     <Status>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O      1
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     </Status>
2013-08-08T20:43:33+04:00 INFO: [31529]  
Horde_Core_ActiveSync_Driver::getMessage(INBOX, 577)
2013-08-08T20:43:33+04:00 INFO: Sending PLAINTEXT Message.
2013-08-08T20:43:33+04:00 INFO: Validating UTF-8 data coming from utf-8
2013-08-08T20:43:33+04:00 INFO: FETCHING VERB
2013-08-08T20:43:33+04:00 INFO: RETURNING VERB
2013-08-08T20:43:33+04:00 DEBUG: [31529] O     <Commands>
2013-08-08T20:43:33+04:00 DEBUG: [31529] O      <Add>

... and so on.

>> >>> 3.  Calendar events created on devices are not synced due to
>> >>> TimeZone error (ERR: No timezone found for the given offsets)
>> >>
>> >> ..and *what* timezone is being sent from the device? Also, would need
>> >> to see the sync log.
>
> Mail RT log. 86aa7f74562fcbd7299ba5865312a35b.zip:  
> https://kouvykov.com:5001/fbsharing/52DfTOgO

This timezone parses fine for me. Maybe your php timezone db is  
corrupt or out of date? The following should output 'GST':
<code>
$blob =  
'EP///1IAdQBzAHMAaQBhAG4AIABTAHQAYQBuAGQAYQByAGQAIABUAGkAbQBlAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAFIAdQBzAHMAaQBhAG4AIABEAGEAeQBsAGkAZwBoAHQAIABUAGkAbQBlAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==';

$offsets = Horde_ActiveSync_Timezone::getOffsetsFromSyncTZ($blob);
$tz = new Horde_ActiveSync_Timezone();
var_dump($tz->getTimezone($blob));
</code>

If it doesn't, your timezone db doesn't contain the needed timezone to  
parse it.

-- 
mike

The Horde Project (www.horde.org)
mrubinsk at horde.org
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-keys
Size: 2200 bytes
Desc: PGP Public Key
URL: <http://lists.horde.org/archives/sync/attachments/20130812/6356499f/attachment.bin>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/pkcs7-signature
Size: 6062 bytes
Desc: S/MIME Signature
URL: <http://lists.horde.org/archives/sync/attachments/20130812/6356499f/attachment-0001.bin>