New ticket submitted by camel camel at 2011/02/09 16:34
Tracking System: Bugs
Category: ActiveSync
Version: Trunk
Status: Open
Completed: 0%
Priority: 5 - medium
Created By: camel camel
Created on: 2011/02/09 16:34
Assigned to: Philip Herbert
Summary: #2846 - calendar - cache reset correct ?
if i sync, it does on ever check write a log list to debug … is this normal
02/09/11 15:28:33 [31956] 1137 messages in state
???
for me - it seems to be, that the cache reset doesn’T work, or is it normal, that all items are checked ?
i sync with EGW AS server …(~2230 items in calendar list of EGW-calendar)
see log…
02/09/11 15:28:33 [31984] Start ------ THIS IS AN UNOFFICIAL DEVELOPER VERSION!
02/09/11 15:28:33 [31984] Z-Push version: SVN AS14 checkout
02/09/11 15:28:33 [31984] Client IP: 80.75.55.136
02/09/11 15:28:33 [31984] Client supports version 12.1
02/09/11 15:28:33 [31956] Start ------ THIS IS AN UNOFFICIAL DEVELOPER VERSION!
02/09/11 15:28:33 [31956] Z-Push version: SVN AS14 checkout
02/09/11 15:28:33 [31956] Client IP: 80.75.55.136
02/09/11 15:28:33 [31956] Client supports version 12.1
02/09/11 15:28:33 [31984] BackendEGW::Logon(‘ms’,‘domain-test.com’,…) logon SUCCESS
02/09/11 15:28:33 [31984] POST cmd: FolderSync
02/09/11 15:28:33 [31984] I
02/09/11 15:28:33 [31984] I
02/09/11 15:28:33 [31984] I {046b3083-611e-4efc-9696-6fad28a6f1e3}1
02/09/11 15:28:33 [31984] I
02/09/11 15:28:33 [31984] Statemachine _devid initialized with samsung1354781040943760
02/09/11 15:28:33 [31984] GetSyncState: File /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/{046b3083-611e-4efc-9696-6fad28a6f1e3}1 read
02/09/11 15:28:33 [31984] GetSyncState: Size of syncstate is 535
02/09/11 15:28:33 [31984] GetSyncState: File /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/s{046b3083-611e-4efc-9696-6fad28a6f1e3}1 read
02/09/11 15:28:33 [31984] GetSyncState: Size of syncstate is 180
02/09/11 15:28:33 [31984] GetSyncState OK
02/09/11 15:28:33 [31984] I
02/09/11 15:28:33 [31984] Initializing folder diff engine
02/09/11 15:28:33 [31984] felamimail_activesync::GetFolderList134
02/09/11 15:28:33 [31956] BackendEGW::Logon(‘ms’,‘domain-test.com’,…) logon SUCCESS
02/09/11 15:28:33 [31956] POST cmd: Sync
02/09/11 15:28:33 [31956] Statemachine _devid initialized with samsung1354781040943760
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I {d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}336
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I 200002EEB00000000
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I 5
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] Sync folder:Calendar
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I 0
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I 1
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I 400000
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] During Sync onlyoptionbodypreference is true
02/09/11 15:28:33 [31956] GetSyncState: File /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/{d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}336 read
02/09/11 15:28:33 [31956] GetSyncState: Size of syncstate is 94409
02/09/11 15:28:33 [31956] GetSyncState: Removing old Sync Key /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/{d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}334
02/09/11 15:28:33 [31956] Removing 1 from confirmed_synckeys array
02/09/11 15:28:33 [31956] strlen collection is 94409
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] I
02/09/11 15:28:33 [31956] Removing SyncCache[synckey] from collection A0000000000000000
02/09/11 15:28:33 [31956] Adding SyncCache[synckey] from collection 200002EEB00000000
02/09/11 15:28:33 [31956] dataavailable: No dataimported: No
02/09/11 15:28:33 [31956] New Synckey generated because importedchanges: getchanges: 1 initialsync:
02/09/11 15:28:33 [31956] Exporter Value: 1
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O {d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}337
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O 200002EEB00000000
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] O 1
02/09/11 15:28:33 [31956] O
02/09/11 15:28:33 [31956] FilterType for getchanges 0
02/09/11 15:28:33 [31956] During GetChangeCount onlyoptionbodypreference is true
02/09/11 15:28:33 [31956] strlen collection is 94409
02/09/11 15:28:33 [31956] Initializing message diff engine
02/09/11 15:28:33 [31956] 1137 messages in state
02/09/11 15:28:33 [31984] felamimail_activesync::GetFolderList() returning Array([id] => A0000000000000000[mod] => INBOX[parent] => 0)
02/09/11 15:28:33 [31956] calendar_activesync::GetMessageList(‘200002EEB00000000’,0)
02/09/11 15:28:33 [31984] addressbook_activesync::GetFolderList() returning Array([0] => Array([id] => 100002EEB00000000[mod] => persönlich[parent] => 0))
02/09/11 15:28:33 [31984] Found 0 folder changes
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O 1
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O {046b3083-611e-4efc-9696-6fad28a6f1e3}1
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O 0
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] O
02/09/11 15:28:33 [31984] setSyncState: Try writing to file /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/{046b3083-611e-4efc-9696-6fad28a6f1e3}2
02/09/11 15:28:33 [31984] setSyncState: Size of syncstate is 535
02/09/11 15:28:33 [31984] setSyncState: Try writing to file /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/s{046b3083-611e-4efc-9696-6fad28a6f1e3}2
02/09/11 15:28:33 [31984] setSyncState: Size of syncstate is 180
02/09/11 15:28:33 [31984] Output Results: GZip not used send Original Size 63 byte(s) --> Send uncompressed data
02/09/11 15:28:34 [31956] calendar_activesync::StatMessage(‘200002EEB00000000’,‘3589’) returning Array([mod] => 3589:0:1297242069[id] => 3589[flags] => 1)
02/09/11 15:28:34 [31956] calendar_activesync::StatMessage(‘200002EEB00000000’,‘3922’) returning Array([mod] => 3922:0:1296905790[id] => 3922[flags] => 1) #CUT #####################################################
now here are comming ~ 1400 lines of “StatMessage”… #CUT #####################################################
02/09/11 15:28:35 [31956] calendar_activesync::StatMessage(‘200002EEB00000000’,‘6146’) returning Array([mod] => 6146:0:1297092625[id] => 6146[flags] => 1)
02/09/11 15:28:35 [31956] calendar_activesync::StatMessage(‘200002EEB00000000’,‘5014’) returning Array([mod] => 5014:1:1297092626[id] => 5014[flags] => 1)
02/09/11 15:28:35 [31956] Found 0 message changes
02/09/11 15:28:35 [31956] Changecount vs maxitems: 0 5
02/09/11 15:28:35 [31956] During Synchronize onlyoptionbodypreference is true
02/09/11 15:28:35 [31956] strlen collection is 94409
02/09/11 15:28:35 [31956] After Exporting Changes we still have following array_rf in importer: Array
(
)
02/09/11 15:28:35 [31956] After manual export of read and flag changes we still have following array_rf in importer: Array
(
)
02/09/11 15:28:35 [31956] O
02/09/11 15:28:35 [31956] During newsynckey onlyoptionbodypreference is true
02/09/11 15:28:35 [31956] strlen collection is 94409
02/09/11 15:28:35 [31956] setSyncState: Try writing to file /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/{d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}337
02/09/11 15:28:35 [31956] setSyncState: Size of syncstate is 94409
02/09/11 15:28:35 [31956] Current Synckey: {d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}336 New Synckey: {d05c6fd2-dc20-40d2-aabd-43ae8cf4fb6a}337
02/09/11 15:28:35 [31956] O
02/09/11 15:28:35 [31956] O
02/09/11 15:28:35 [31956] Output Results: GZip not used send Original Size 81 byte(s) --> Send uncompressed data
02/09/11 15:28:35 [31984] Header Connection aborted :no
02/09/11 15:28:35 [31984] Header Connection status :0
02/09/11 15:28:37 [31956] Header Connection aborted :no
02/09/11 15:28:37 [31956] Header Connection status :0
02/09/11 15:28:37 [31984] Body Connection aborted :no
02/09/11 15:28:37 [31984] Body Connection status :0
02/09/11 15:28:37 [31984] LOGOFF
02/09/11 15:28:37 [31984] end
02/09/11 15:28:37 [31984] --------
02/09/11 15:28:39 [31956] Body Connection aborted :no
02/09/11 15:28:39 [31956] Body Connection status :0
02/09/11 15:28:39 [31956] LOGOFF
02/09/11 15:28:39 [31956] end
02/09/11 15:28:39 [31956] --------
02/09/11 15:28:39 [31984] verifyCommunication: Device should have the data!
02/09/11 15:28:41 [31956] verifyCommunication: Cachestatus is 1
02/09/11 15:28:41 [31956] verifyCommunication: Created /var/lib/egroupware/domain-test.com/files/activesync/samsung1354781040943760/HANDLESYNC_NO_SHORT_REQUEST since change occured to get full sync request from client
linked entries:
http://www.egroupware.org/egroupware/index.php?menuaction=tracker.tracker_ui.edit&tr_id=2846&no_popup=1