[Tickets #12544] Activesync fails to sync inbox if sms upload from device

[noreply at bugs.horde.org]

DO NOT REPLY TO THIS MESSAGE. THIS EMAIL ADDRESS IS NOT MONITORED.

Ticket URL: http://bugs.horde.org/ticket/12544
------------------------------------------------------------------------------
  Ticket             | 12544
  Created By         | carlos.velasco at nimastelecom.com
  Summary            | Activesync fails to sync inbox if sms upload from
                     | device
  Queue              | Synchronization
  Version            | Git master
  Type               | Bug
  State              | Unconfirmed
  Priority           | 2. Medium
  Milestone          |
  Patch              |
  Owners             |
------------------------------------------------------------------------------


carlos.velasco at nimastelecom.com (2013-08-07 21:26) wrote:

First of all, I really don't know if sms syncing works in horde, but  
it is activated by default in Android.

When device place SMS in Inbox it tries to upload it through  
ActiveSync. Horde fails with error "Unmatched end tag" and sends  
Status 4, this breaks the Email sync, no new mail is synced after this  
error.

Related somehow to Bug: 12281

AS logs:
2013-08-07T22:48:40+02:00 DEBUG: [483] I     <Commands>
2013-08-07T22:48:40+02:00 INFO: [483] Obtaining collection class of  
Email for collection id 6b55a45a
2013-08-07T22:48:40+02:00 INFO: [483] Initializing state for  
collection: INBOX, synckey: {52026a83-5f34-41de-96d2-6e395570088c}5
2013-08-07T22:48:40+02:00 INFO: [483] Loading state for synckey  
{52026a83-5f34-41de-96d2-6e395570088c}5
2013-08-07T22:48:40+02:00 DEBUG: [483] I      <Add>
2013-08-07T22:48:40+02:00 DEBUG: [483] I       <FolderType>
2013-08-07T22:48:40+02:00 DEBUG: [483] I         SMS
2013-08-07T22:48:40+02:00 DEBUG: [483] I       </FolderType>
2013-08-07T22:48:40+02:00 DEBUG: [483] I       <ClientEntryId>
2013-08-07T22:48:40+02:00 DEBUG: [483] I         SMS_1375894660369
2013-08-07T22:48:40+02:00 DEBUG: [483] I       </ClientEntryId>
2013-08-07T22:48:40+02:00 DEBUG: [483] I       <Data>
2013-08-07T22:48:40+02:00 DEBUG: [483] I        <POOMMAIL:To>
2013-08-07T22:48:40+02:00 ERR: [483] Unmatched end tag:
2013-08-07T22:48:40+02:00 ERR: Array
(
     [1] => 1
     [2] => POOMMAIL:To
     [4] => 1
)

2013-08-07T22:48:40+02:00 DEBUG: [483] O  <Synchronize>
2013-08-07T22:48:40+02:00 DEBUG: [483] O   <Status>
2013-08-07T22:48:40+02:00 DEBUG: [483] O    4
2013-08-07T22:48:40+02:00 DEBUG: [483] O   </Status>
2013-08-07T22:48:40+02:00 DEBUG: [483] O  </Synchronize>

The decoded TCP packet shows a "To" field empty:
             5 | Tag   | T   0    |   Known Tag 0x0C           (.C) |   
           <ClientId>
             5 | Tag   | T   0    | STR_I (Inline string)           |   
           'SMS_1375894660369'
             5 | Tag   | T   0    | END (Known Tag 0x0C)            |   
           </ClientId>
             5 | Tag   | T   0    |   Known Tag 0x1D           (.C) |   
           <ApplicationData>
               | Tag   | T -->  2 | SWITCH_PAGE (Tag code page)     |
             6 | Tag   | T   2    |   Known Tag 0x16           (.C) |   
             <To>
             6 | Tag   | T   2    | STR_I (Inline string)           |   
             ''
             6 | Tag   | T   2    | END (Known Tag 0x16)            |   
             </To>
             6 | Tag   | T   2    |   Known Tag 0x18           (.C) |   
             <From>
             6 | Tag   | T   2    | STR_I (Inline string)           |   
             '555555555'
             6 | Tag   | T   2    | END (Known Tag 0x18)            |   
             </From>

Uploading full decoded Sync request (some data changed for privacy).




carlos.velasco at nimastelecom.com (2013-08-07 21:26) uploaded: sync_add_sms.txt

http://bugs.horde.org/h/services/download/?app=whups&actionID=download_file&file=sync_add_sms.txt&ticket=12544&fn=%2Fsync_add_sms.txt