Tickets :: [#12367] Outlook 2013/EAS crashes during sync

6.0.0-alpha14

7/3/25

Summary	Outlook 2013/EAS crashes during sync
Queue	Synchronization
Queue Version	Git master
Type	Bug
State	Not A Bug
Priority	1. Low
Owners
Requester	torben (at) dannhauer (dot) info
Created	06/18/2013 (4398 days ago)
Due
Updated	07/08/2013 (4378 days ago)
Assigned	06/18/2013 (4398 days ago)
Resolved	07/08/2013 (4378 days ago)
Github Issue Link
Github Pull Request
Milestone
Patch	No

07/08/2013 08:05:31 PM	rbe (at) tritem (dot) net	Comment #9	Reply to this comment
Done

07/08/2013 04:08:03 PM	Michael Rubinsky	Comment #8 State ⇒ Not A Bug Priority ⇒ 1. Low	Reply to this comment
Feel free to add this information to the wiki http://http://wiki.horde.org/ActiveSync/KnownIssues

07/08/2013 11:59:02 AM	rbe (at) tritem (dot) net	Comment #7	Reply to this comment
Hi, I finally found where was located the problem. Nothing related to the EASCache or RoamCache folders like i was guessing before. The problem is issued by an addin called "Outlook Mail Notifier" (c:\Program Files\Common Files\Apple\Mobile Device Support\OutlookChangeNotifierAddIn.dll) belonging to Apple Mobile Device Support. For an unknown reason, this addin adds an extra activity line in the outlook connection status windows (click <ctrl>+mouse right click on the systray outlook icon, then connection status). The main activity line belongs to the EAS connection. This extra connection can't be established and bring on the permanent message "this folder hasn't yet been update, connection attempt". Disabling that addin solves the problem. Hope it can help OL2013 users with itunes installed. Kinds regards Richard

07/07/2013 09:44:56 AM	rbe (at) tritem (dot) net	Comment #6 New Attachment: 532F475B99C24FB5B9BE1E37063C3FEF.txt.gz	Reply to this comment
Hi again, I ran a bundle of extra tests after my previous post, here are the results : Test context - creation of a new LDAP account test2.tritem - log in with the credential in imp (folder inbox only) - setting up identity - sending of a test email (==> folders inbox and sent are available) - manual creation of 2 folders Trash and Junk - setting up deleted messages and junk preferences - imp displays now the folders inbox, sent, trash and junk - setting up the EAS account in OL2013 - starting up OL 2013 : no crash but always the "this folder hasn't yet been updated ... - Sending, deleting and moving messages, creating appointments, tasks in imp and outlook : synchro OK - closing OL2013 Then, i stopped apache and connected to my outlook profile. Same message but in state disconnected (seems a normal behaviour). I restarted apache, then OL2013. Same behaviour than before. At this point, i guess the "problem" (everything works except this weird message) comes from the way outlook is caching the informations in the OST file and the EASCache and RoamCache folders. I tried to delete the .bin file in the EASCache folder and restart OL2013. Still the same. I'll make later further tests in a VM because it seems not so simple to delete the targeted content of the RoamCache folder relative to a specific profile. My main profile is working well except double messaging in the junk folder (maybe a cache problem too). I'll keep you informed of the results. Kind regards Richard

07/07/2013 06:52:04 AM	rbe (at) tritem (dot) net	Comment #5	Reply to this comment
Hi Michael, Many thanks for yor responsive support. Like you, i don't have at this moment any more clues to further analyse this problem. I'm currently experiencing the horde project to replace my company old mail/webmail system. It's a very strong and powerful product i chose among many tested (zarafa, SoGO, roundcube, ...). I was especially seduced and impressed by the modular approach (framework, imp, kronolith, EAS, ...), the administration functions and the adaptable interface (web browser, smarphone, ...). Many thanks for this. I'm french and concerned by internationalization aspects. I run horde on a CentOS 6.4 with pear and pecl modules (not the yum ones). I use the last versions provided by the horde administration interface. I perhaps should use the last git versions. At this point of our experience, we are about 5 testers with different devices (iphone with ios 4,5 and 6, windows phone 8, outlook 2013). All is working well except the problem with OL2013 and a few minor things. I'm also planning to test android devices soon. I'm using OL2013/WP8 (with my personal LDAP and EAS profile) without the problem described before. I made a lot of manipulations between imp and OL2013 before the problem goes away. Unfortunately, i don't remind the exact sequence and have no detailed logs (i haven't setted up the isolation of AS log at this time ...) I guess the problem occurs (OL2013 side only) when all the folders are not configured/created with imp (sent, trash, junk) and OL2013 tries to sync with them. It's only a feeling at this time and i will run further tests to bring you detailed informations. I will post as soon as it will be done. Kind regards Richard

07/07/2013 03:27:34 AM	Michael Rubinsky	Comment #4	Reply to this comment
I am not able to reproduce any crash using OL 2013. I've tried two different windows 7 machines and a number of Horde accounts (I don't have windows 8). I have not found any errors in your logs though I did notice that OL sends both a global and collection level WINDOWSIZE element. This is allowed, but we are not handling this case 100% correctly in code. I've fixed this in git. This leads to a more responsive initial sync if you have lots of folders and lots of email in each folder. According to your bug report though, this is not the case for you. The only thing close to a "crash" that I have encountered is Outlook can sometimes become "unresponsive" if I try to view a folder that hasn't fully loaded yet, but once the folder loads, it comes back alive. Nothing we can do about that from the Horde end, unfortunately. The log continuing to run after you shut down OL is expected. It's because the PHP process will continue to loop for the current PING lifetime. Unless someone can demonstrate/identify some incorrect data that Horde is sending that causes OL to crash, there is really nothing I can do about this.

07/06/2013 07:18:27 PM	rbe (at) tritem (dot) net	Comment #3 New Attachment: 889EDB3898A3451FA1DB9CB6AD0C2C09.txt.gz	Reply to this comment
Hi, I have the same problem with Outlook 2013 and EAS. After several tests, here is the test context. 1) Creation of a LDAP test account 2) Log in to IMP. All is OK (only inbox folder for the moment) 3) Log off After setting up the EAS account in the windows control panel, the first outlook start failed after 10-15 seconds. Starting again outlook works but i have the following message " this folder has not yet been updated, connection attempt" which never disappears. I looked at the activesync log but it shows no error, as far as i can analyse. I note something weird. The activesync log continues to be updated even after i close Outlook. It always end with "sleeping for 15 seconds" and logs so on. It stops logging if i restart my apache server. I can reproduce this behaviour each time and it seems to be specific to Outlook 2013. I'm running a 64 bits version on Windows 8 Pro. You can find the activesync log in the attachment. Thanks for your return. Richard

06/18/2013 03:12:24 PM	Michael Rubinsky	Comment #2 State ⇒ Feedback	Reply to this comment
After setting up the account with email, tasks, contacts and calendar data, it syncs fine for a while but some minutes later (still syncing) Outlook crashes. I'm not seeing this. Please find attached the last part of the sync log, maybe it helps. is the " [6] => 0" at the end of he log (see snipped part) valid? Yes. It signifies that there were no "left over" messages to send in the next sync. Additionally, I don't see anything else odd in the log snipped you've included.

06/18/2013 06:33:17 AM	torben (at) dannhauer (dot) info	Comment #1 State ⇒ Unconfirmed Patch ⇒ No Milestone ⇒ Queue ⇒ Synchronization Summary ⇒ Outlook 2013/EAS crashes during sync Type ⇒ Bug Priority ⇒ 2. Medium	Reply to this comment
After setting up the account with email, tasks, contacts and calendar data, it syncs fine for a while but some minutes later (still syncing) Outlook crashes. After that starting outlook fails since it crashes always immediately after startup. Removing the EAS account from Outlook via the system control panel solves the issue (then of course without EAS account). Please find attached the last part of the sync log, maybe it helps. is the " [6] => 0" at the end of he log (see snipped part) valid? <snip> [2] => A7E2EC12F0D6402D9CFFFE6968B64DA0 [3] => 1371535521 [4] => fc50c15f [5] => torben@dannhauer.info [6] => 0 </snip> P.S.: I use courier-imap. Thanks, Torben ------- LOG --------------- [...] 2013-06-18T08:05:23+02:00 INFO: [30772] Updating state during change 2013-06-18T08:05:23+02:00 INFO: [30772] Horde_Core_ActiveSync_Driver::getMessage(INBOX.CHM.Zertifizierung CHM.Kundenfeedback 2012, 9) 2013-06-18T08:05:23+02:00 INFO: Sending MIME Message. 2013-06-18T08:05:23+02:00 INFO: Validating UTF-8 data coming from iso-8859-1 2013-06-18T08:05:23+02:00 INFO: Checking MIMETRUNCATION: 1048576, ServerData: 286938 2013-06-18T08:05:23+02:00 INFO: FETCHING VERB 2013-06-18T08:05:23+02:00 INFO: RETURNING VERB 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <Add> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <ServerEntryId> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 9 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </ServerEntryId> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <Data> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:To> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O torben@dannhauer.info 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:To> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:From> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O Foreign User <foreign.user@domain.tld> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:From> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:Subject> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O WG: MySubject 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:Subject> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:ThreadTopic> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O WG: MySubject 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:ThreadTopic> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:DateReceived> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 2013-03-02T12:08:07.000Z 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:DateReceived> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:DisplayTo> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O Dannhauer_Torben 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:DisplayTo> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:Importance> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 1 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:Importance> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:Read> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 1 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:Read> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:MessageClass> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O IPM.Note 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:MessageClass> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:Reply-To> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O Foreign User <foreign.user@domain.tld> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:Reply-To> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:InternetCPID> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 65001 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:InternetCPID> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:NativeBodyType> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 1 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:NativeBodyType> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Body> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Type> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 4 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Type> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:EstimatedDataSize> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 286938 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:EstimatedDataSize> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Truncated> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 0 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Truncated> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Data> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O [STREAM] 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Data> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Body> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Attachments> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Attachment> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:DisplayName> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O MyAttachment[1].docx 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:DisplayName> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:FileReference> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O INBOX.XXX.XXXXXXXXXXXXXX XXX.XXXXXXXXXXXXXX XXXX:9:2 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:FileReference> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:Method> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 1 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Method> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <AirSyncBase:EstimatedDataSize> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 283642 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:EstimatedDataSize> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Attachment> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </AirSyncBase:Attachments> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:Flag/> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL:ContentClass> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O urn:content-classes:message 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL:ContentClass> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL2:LastVerbExecuted> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 1 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL2:LastVerbExecuted> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O <POOMMAIL2:LastVerbExecutionTime> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O 2013-06-18T06:05:23.000Z 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </POOMMAIL2:LastVerbExecutionTime> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Data> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Add> 2013-06-18T08:05:23+02:00 INFO: [30772] Updating state during change 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Commands> 2013-06-18T08:05:23+02:00 INFO: [30772] Saving state: Array ( [0] => {51bff44a-f15c-4691-be77-78344e2ee3d4}2 [1] => Horde_Db_Value_Binary Object ( [_value:protected] => C:28:"Horde_ActiveSync_Folder_Imap":602:{a:5:{s:1:"s";a:3:{s:7:"uidnext";s:2:"10";s:11:"uidvalidity";s:10:"1362554944";s:13:"highestmodseq";i:0;}s:1:"m";a:9:{i:1;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:2;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:3;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:4;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:5;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:6;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:7;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:8;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}i:9;a:2:{s:4:"read";i:1;s:7:"flagged";i:0;}}s:1:"f";s:48:"INBOX.XXX.XXXXXXXXXXXXXX XXX.XXXXXXXXXXXXXX XXXX";s:1:"c";s:5:"Email";s:1:"v";i:1;}} ) [2] => A7E2EC12F0D6402D9CFFFE6968B64DA0 [3] => 1371535521 [4] => fc50c15f [5] => torben@dannhauer.info [6] => 0 ) 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Folder> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Folders> 2013-06-18T08:05:23+02:00 DEBUG: [30772] O </Synchronize> 2013-06-18T08:05:23+02:00 INFO: Changes detected in sync_cache during wait interval, exiting without updating cache. 2013-06-18T08:05:23+02:00 INFO: [30772] User torben@dannhauer.info logged off