ActiveSync: Problems when syncing

Jochen May jochen at jmay.org
Wed Jul 10 12:44:09 CEST 2013


Am Montag, 8. Juli 2013, 20:21:57 schrieb Jochen May:
> Am Montag, 8. Juli 2013, 10:14:21 schrieb Torsten Grote:
> > On Sunday 07 July 2013 17:38:10 Jochen May wrote:
>  > > I can not sync with the server. My LG phone says that the server
>  > > is not reachable and i shoud try it later.
>  > 
>  > Does https://yourserver.com/Microsoft-Server-ActiveSync work in your
>  > case,
>  > or also only http?
> 
> Only http works. If i try it with https i get an error that the object is
> not found.
> For the moment http is ok for me....

This morning i played a little bit around. Here are the actual status:

Touchdown App: Mail works, Contact works, Calender not.
LG Stock: Only try Calender - not working. 
moxio: Mail works, Contact works, Calender not. There seems to be a problem 
with recurring events like public holidays. Moxio starts to sync the calender 
and on some point it stucks on an pulicb holiday. This event is syncing again 
and again and again..... I guess that Touchdown have the same problem. But at 
the moment i don´t have any log-files for touchdown.

The LG log files are console [1], imap [2], sql [3]
 
Regards
Jochen


[1]
[10-Jul-2013 12:13:44,000000 +0200]: [DEBUG] Syncroton_Server::handle::61 
REQUEST METHOD: OPTIONS
[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] Syncroton_Server::handle::61 
REQUEST METHOD: POST
[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::103 REQUEST Array
(
    [protocolVersion] => 12.1
    [command] => FolderSync
    [deviceId] => LGMC356216040934715
    [deviceType] => LGPhone
    [policyKey] => 0
    [saveInSent] => 
    [collectionId] => 
    [itemId] => 
    [attachmentName] => 
    [acceptMultipart] => 
    [userAgent] => LGMC-LGEAS/5.151L1A
    [contentType] => application/vnd.ms-sync.wbxml
)

[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::126 xml request:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<FolderSync xmlns="uri:FolderHierarchy">
  <SyncKey>0</SyncKey>
</FolderSync>

[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] 
Syncroton_Command_Wbxml::__construct::163 sync timestamp: 2013-07-10 10:13:45
[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] 
Syncroton_Command_FolderSync::handle::79 synckey is 0
[10-Jul-2013 12:13:45,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::176 xml response:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<FolderSync xmlns="uri:FolderHierarchy" xmlns:Syncroton="uri:Syncroton" 
xmlns:Internal="uri:Internal">
  <Status>1</Status>
  <SyncKey>1</SyncKey>
  <Changes>
    <Count>6</Count>
    <Add>
      <ServerId>Calendar::Syncroton</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Calendar</DisplayName>
      <Type>8</Type>
    </Add>
    <Add>
      <ServerId>Contacts::Syncroton</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Contacts</DisplayName>
      <Type>9</Type>
    </Add>
    <Add>
      <ServerId>Inbox</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Inbox</DisplayName>
      <Type>2</Type>
    </Add>
    <Add>
      <ServerId>Drafts</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Drafts</DisplayName>
      <Type>3</Type>
    </Add>
    <Add>
      <ServerId>Sent Items</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Sent Items</DisplayName>
      <Type>5</Type>
    </Add>
    <Add>
      <ServerId>Deleted Items</ServerId>
      <ParentId>0</ParentId>
      <DisplayName>Deleted Items</DisplayName>
      <Type>4</Type>
    </Add>
  </Changes>
</FolderSync>

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] Syncroton_Server::handle::61 
REQUEST METHOD: POST
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::103 REQUEST Array
(
    [protocolVersion] => 12.1
    [command] => Settings
    [deviceId] => LGMC356216040934715
    [deviceType] => LGPhone
    [policyKey] => 0
    [saveInSent] => 
    [collectionId] => 
    [itemId] => 
    [attachmentName] => 
    [acceptMultipart] => 
    [userAgent] => LGMC-LGEAS/5.151L1A
    [contentType] => application/vnd.ms-sync.wbxml
)

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::126 xml request:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<Settings xmlns="uri:Settings">
  <DeviceInformation>
    <Set>
      <Model>LG-P990</Model>
      <IMEI>356216040934715</IMEI>
      <FriendlyName>LG-P990</FriendlyName>
      <OS>Android4.0.4</OS>
      <OSLanguage>de</OSLanguage>
      <PhoneNumber>+491714213147</PhoneNumber>
    </Set>
  </DeviceInformation>
</Settings>

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Command_Wbxml::__construct::163 sync timestamp: 2013-07-10 10:13:46
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::176 xml response:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<Settings xmlns="uri:Settings" xmlns:Syncroton="uri:Syncroton">
  <Status>1</Status>
  <DeviceInformation>
    <Set>
      <Status>1</Status>
    </Set>
  </DeviceInformation>
</Settings>

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] Syncroton_Server::handle::61 
REQUEST METHOD: POST
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::103 REQUEST Array
(
    [protocolVersion] => 12.1
    [command] => Sync
    [deviceId] => LGMC356216040934715
    [deviceType] => LGPhone
    [policyKey] => 0
    [saveInSent] => 
    [collectionId] => 
    [itemId] => 
    [attachmentName] => 
    [acceptMultipart] => 
    [userAgent] => LGMC-LGEAS/5.151L1A
    [contentType] => application/vnd.ms-sync.wbxml
)

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::126 xml request:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<Sync xmlns="uri:AirSync">
  <Collections>
    <Collection>
      <SyncKey>0</SyncKey>
      <CollectionId>Inbox</CollectionId>
      <DeletesAsMoves/>
    </Collection>
  </Collections>
</Sync>

[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Command_Wbxml::__construct::163 sync timestamp: 2013-07-10 10:13:46
[10-Jul-2013 12:13:46,000000 +0200]: [INFO] 
Syncroton_Command_Sync::handle::196 SyncKey is 0 Class: Email CollectionId: 
Inbox
[10-Jul-2013 12:13:46,000000 +0200]: [INFO] 
Syncroton_Command_Sync::handle::201 initial client synckey 0 provided
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Command_Sync::getResponse::874 update syncState for collection: 
Inbox
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
kolab_sync_transaction_manager::startTransaction::102  startTransaction 
request
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
kolab_sync_transaction_manager::startTransaction::107  new transactionable. 
Starting transaction on this resource
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
kolab_sync_transaction_manager::startTransaction::126  queued transaction with 
id d60150c1c44f4f97a0556fcbd945769968ec5445
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
kolab_sync_transaction_manager::commitTransaction::141  commitTransaction 
request for d60150c1c44f4f97a0556fcbd945769968ec5445
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
kolab_sync_transaction_manager::commitTransaction::153  no more open 
transactions in queue commiting all transactionables
[10-Jul-2013 12:13:46,000000 +0200]: [DEBUG] 
Syncroton_Server::_handlePost::176 xml response:
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" 
"http://www.microsoft.com/">
<Sync xmlns="uri:AirSync" xmlns:Syncroton="uri:Syncroton">
  <Collections>
    <Collection>
      <Class>Email</Class>
      <SyncKey>1</SyncKey>
      <CollectionId>Inbox</CollectionId>
      <Status>1</Status>
    </Collection>
  </Collections>
</Sync>
 
[2]
[10-Jul-2013 12:13:44,000000 +0200]: [CB71] C: A0006 LOGOUT
[10-Jul-2013 12:13:44,000000 +0200]: [CB71] S: * BYE LOGOUT received
[10-Jul-2013 12:13:44,000000 +0200]: [CB71] S: A0006 OK Completed
[10-Jul-2013 12:13:45,000000 +0200]: [5DBC] C: A0006 LOGOUT
[10-Jul-2013 12:13:45,000000 +0200]: [5DBC] S: * BYE LOGOUT received
[10-Jul-2013 12:13:45,000000 +0200]: [5DBC] S: A0006 OK Completed
[10-Jul-2013 12:13:46,000000 +0200]: [2875] C: A0006 LOGOUT
[10-Jul-2013 12:13:46,000000 +0200]: [2875] S: * BYE LOGOUT received
[10-Jul-2013 12:13:46,000000 +0200]: [2875] S: A0006 OK Completed
[10-Jul-2013 12:13:46,000000 +0200]: [138D] C: A0006 LOGOUT
[10-Jul-2013 12:13:46,000000 +0200]: [138D] S: * BYE LOGOUT received
[10-Jul-2013 12:13:46,000000 +0200]: [138D] S: A0006 OK Completed 

[3]
[10-Jul-2013 12:13:45,000000 +0200]: [3] SELECT * FROM syncroton_device WHERE 
`deviceid` = 'LGMC356216040934715' AND `owner_id` = '3';
[10-Jul-2013 12:13:45,000000 +0200]: [4] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.metadata.INBOX.4ea34792fde4aa45b17a28c7a6be19a1' ORDER BY 
created DESC LIMIT 1;
[10-Jul-2013 12:13:45,000000 +0200]: [5] DELETE FROM syncroton_synckey WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `type` = 
'FolderSync';
[10-Jul-2013 12:13:45,000000 +0200]: [6] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.metadata.*.446be42f5518b0285ccbea93f318d096' ORDER BY created 
DESC LIMIT 1;
[10-Jul-2013 12:13:45,000000 +0200]: [7] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.metadata.*.4ea34792fde4aa45b17a28c7a6be19a1' ORDER BY created 
DESC LIMIT 1;
[10-Jul-2013 12:13:45,000000 +0200]: [8] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `class` = 
'Calendar';
[10-Jul-2013 12:13:45,000000 +0200]: [9] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `class` = 
'Contacts';
[10-Jul-2013 12:13:45,000000 +0200]: [10] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.list.52e1b99e06a8329123cb018461fe3894' ORDER BY created DESC 
LIMIT 1;
[10-Jul-2013 12:13:45,000000 +0200]: [11] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `class` = 
'Email';
[10-Jul-2013 12:13:45,000000 +0200]: [12] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `class` = 
'Tasks';
[10-Jul-2013 12:13:45,000000 +0200]: [13] INSERT INTO syncroton_synckey 
(`device_id`, `counter`, `type`, `lastsync`, `id`) 
VALUES('db8a0b6c3807035e8fa53159dd4949d777642a48', '1', 'FolderSync', 
'2013-07-10 10:13:45', '4a937e5fd1aa0db5cd2c51dba95495ab37628b2e');
[10-Jul-2013 12:13:46,000000 +0200]: [3] SELECT * FROM syncroton_device WHERE 
`deviceid` = 'LGMC356216040934715' AND `owner_id` = '3';
[10-Jul-2013 12:13:46,000000 +0200]: [4] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.metadata.INBOX.4ea34792fde4aa45b17a28c7a6be19a1' ORDER BY 
created DESC LIMIT 1;
[10-Jul-2013 12:13:46,000000 +0200]: [5] UPDATE syncroton_device SET `id` = 
'db8a0b6c3807035e8fa53159dd4949d777642a48', `deviceid` = 
'LGMC356216040934715', `devicetype` = 'LGPhone', `owner_id` = '3', 
`acsversion` = '12.1', `policykey` = NULL, `policy_id` = NULL, `useragent` = 
'LGMC-LGEAS/5.151L1A', `imei` = '356216040934715', `model` = 'LG-P990', 
`friendlyname` = 'LG-P990', `os` = 'Android4.0.4', `oslanguage` = 'de', 
`phonenumber` = '+491714213147', `pinglifetime` = NULL, `remotewipe` = '0', 
`pingfolder` = NULL, `contactsfilter_id` = NULL, `calendarfilter_id` = NULL, 
`tasksfilter_id` = NULL, `emailfilter_id` = NULL WHERE `id` = 
'db8a0b6c3807035e8fa53159dd4949d777642a48';
[10-Jul-2013 12:13:46,000000 +0200]: [3] SELECT * FROM syncroton_device WHERE 
`deviceid` = 'LGMC356216040934715' AND `owner_id` = '3';
[10-Jul-2013 12:13:46,000000 +0200]: [4] SELECT data, cache_key FROM cache 
WHERE user_id = '3' AND cache_key = 
'IMAP.mailboxes.metadata.INBOX.4ea34792fde4aa45b17a28c7a6be19a1' ORDER BY 
created DESC LIMIT 1;
[10-Jul-2013 12:13:46,000000 +0200]: [5] UPDATE syncroton_device SET `id` = 
'db8a0b6c3807035e8fa53159dd4949d777642a48', `deviceid` = 
'LGMC356216040934715', `devicetype` = 'LGPhone', `owner_id` = '3', 
`acsversion` = '12.1', `policykey` = NULL, `policy_id` = NULL, `useragent` = 
'LGMC-LGEAS/5.151L1A', `imei` = '356216040934715', `model` = 'LG-P990', 
`friendlyname` = 'LG-P990', `os` = 'Android4.0.4', `oslanguage` = 'de', 
`phonenumber` = '+491714213147', `pinglifetime` = NULL, `remotewipe` = '0', 
`pingfolder` = NULL, `contactsfilter_id` = NULL, `calendarfilter_id` = NULL, 
`tasksfilter_id` = NULL, `emailfilter_id` = NULL, `lastsynccollection` = 
'{\"Inbox\":{\"syncKey\":0,\"collectionId\":\"Inbox\",\"deletesAsMoves\":true,
\"conversationMode\":true,\"getChanges\":true,\"windowSize\":100,\"options\":
{\"filterType\":0,\"mimeSupport\":0,\"mimeTruncation\":8,\"bodyPreferences\":
[]}}}' WHERE `id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48';
[10-Jul-2013 12:13:46,000000 +0200]: [6] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `folderid` = 
'Inbox';
[10-Jul-2013 12:13:46,000000 +0200]: [7] DELETE FROM syncroton_synckey WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `type` = 
'c47175cbd07d5346ba804e13cd43c3f883f3c880';
[10-Jul-2013 12:13:46,000000 +0200]: [8] DELETE FROM syncroton_content WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `folder_id` = 
'c47175cbd07d5346ba804e13cd43c3f883f3c880';
[10-Jul-2013 12:13:46,000000 +0200]: [9] BEGIN;
[10-Jul-2013 12:13:46,000000 +0200]: [10] INSERT INTO syncroton_synckey 
(`device_id`, `counter`, `type`, `lastsync`, `pendingdata`, `id`) 
VALUES('db8a0b6c3807035e8fa53159dd4949d777642a48', '1', 
'c47175cbd07d5346ba804e13cd43c3f883f3c880', '2013-07-10 10:13:47', NULL, 
'efff56860bffa9d112db38ed2b78add298e43aa6');
[10-Jul-2013 12:13:46,000000 +0200]: [11] COMMIT;
[10-Jul-2013 12:13:46,000000 +0200]: [12] SELECT * FROM syncroton_folder WHERE 
`device_id` = 'db8a0b6c3807035e8fa53159dd4949d777642a48' AND `folderid` = 
'Inbox';
[10-Jul-2013 12:13:46,000000 +0200]: [13] UPDATE syncroton_folder SET `id` = 
'c47175cbd07d5346ba804e13cd43c3f883f3c880', `device_id` = 
'db8a0b6c3807035e8fa53159dd4949d777642a48', `class` = 'Email', `folderid` = 
'Inbox', `parentid` = '0', `displayname` = 'Inbox', `type` = '2', 
`creation_time` = '2013-07-07 15:28:25', `lastfiltertype` = NULL WHERE `id` = 
'c47175cbd07d5346ba804e13cd43c3f883f3c880'; 
> _______________________________________________
> users mailing list
> users at lists.kolab.org



More information about the users mailing list