Outlook does not sync any more



  • Hi,

    Outlook 2016 does not sync anymore out of nothing. Wireshark caputes no packets sent by Outlook. Any hints?

    Kopano Addin: 1.3.156

    Outlook: 16.0.0.7870

    Z-Push: 2.3.5+4
    PHP-MAPI: 7.2.4-29

    root@mailrelay:~# zarafa-admin -V
    Product version: 7,2,4,29
    File version: 29

    root@mailrelay:~# uname -a
    Linux mailrelay 3.19.0-25-generic #26~14.04.1-Ubuntu SMP Fri Jul 24 21:16:20 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux

    root@mailrelay:~# lsb_release -a
    No LSB modules are available.
    Distributor ID: Ubuntu
    Description: Ubuntu 14.04.5 LTS
    Release: 14.04
    Codename: trusty

    2017/04/28 06:25:05.227 (1,VSTA_Main): Trace: ThisAddIn: OutlookUI created
    2017/04/28 06:25:05.382 (1,VSTA_Main): Info: ThisAddIn: Starting version 1.3.156: 343705345b7aef675e2e0a1aa37d011171b6cf2f @ 05.04.2017 12:11:19. Outlook version: 16.0.0.7870. Options: ''
    2017/04/28 06:25:05.382 (1,VSTA_Main): Trace: NLogLogger: Level initialized
    2017/04/28 06:25:05.403 (1,VSTA_Main): Info: FeatureReplyFlags: Starting feature: ''
    2017/04/28 06:25:05.407 (1,VSTA_Main): Trace: FeatureReplyFlags: Started feature
    2017/04/28 06:25:05.407 (1,VSTA_Main): Info: FeatureOutOfOffice: Starting feature: ''
    2017/04/28 06:25:05.407 (1,VSTA_Main): Debug: OutOfOffice: Acacia.UI.Outlook.RibbonToggleButton: Registered
    2017/04/28 06:25:05.407 (1,VSTA_Main): Trace: FeatureOutOfOffice: Started feature
    2017/04/28 06:25:05.407 (1,VSTA_Main): Info: FeatureSharedFolders: Starting feature: ''
    2017/04/28 06:25:05.407 (1,VSTA_Main): Debug: SharedFolders: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:25:05.407 (1,VSTA_Main): Debug: SharedFolders: Acacia.UI.Outlook.MenuItem`1[Acacia.Stubs.IFolder]: Registered
    2017/04/28 06:25:05.407 (1,VSTA_Main): Trace: FeatureSharedFolders: Started feature
    2017/04/28 06:25:05.407 (1,VSTA_Main): Info: FeatureWebApp: Starting feature: ''
    2017/04/28 06:25:05.407 (1,VSTA_Main): Debug: WebApp: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:25:05.407 (1,VSTA_Main): Trace: FeatureWebApp: Started feature
    2017/04/28 06:25:05.407 (1,VSTA_Main): Info: FeatureFreeBusy: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureFreeBusy: Started feature
    2017/04/28 06:25:05.427 (1,VSTA_Main): Info: FeatureGAB: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureGAB: Started feature
    2017/04/28 06:25:05.427 (1,VSTA_Main): Info: FeatureNotes: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureNotes: Started feature
    2017/04/28 06:25:05.427 (1,VSTA_Main): Info: FeatureSecondaryContacts: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureSecondaryContacts: Started feature
    2017/04/28 06:25:05.427 (1,VSTA_Main): Info: FeatureSendAs: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureSendAs: Started feature
    2017/04/28 06:25:05.427 (1,VSTA_Main): Info: FeatureSignatures: Starting feature: ''
    2017/04/28 06:25:05.427 (1,VSTA_Main): Trace: FeatureSignatures: Started feature
    2017/04/28 06:25:05.437 (1,VSTA_Main): Info: FeatureDebugSupport: Starting feature: 'Dialog'
    2017/04/28 06:25:05.437 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:25:05.437 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:25:05.437 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:25:05.437 (1,VSTA_Main): Trace: FeatureDebugSupport: Started feature
    2017/04/28 06:25:05.469 (1,VSTA_Main): Debug: ThisAddIn: Startup done
    2017/04/28 06:25:05.872 (6,): Trace: StoresWrapper: New store: firstname.lastname@company.de
    2017/04/28 06:25:05.883 (6,): Trace: StoresWrapper: Account registered: firstname lastname -> 0000000038A1BB1005E5101AA1BB08002B2A56C200007073747072782E646C6C0000000000000000E92FEB759650448683B87DE522AA4948000043003A005C00550073006500720073005C006D006E0069006500770069006E0064005C0041007000700044006100740061005C004C006F00630061006C005C004D006900630072006F0073006F00660074005C004F00750074006C006F006F006B005C006D00690063006800610065006C002E006E0069006500770069006E00640040006D0065007400610067006D00620068002E006400650020002D00200054006500730074002E006F00730074000000
    2017/04/28 06:25:05.883 (6,): Trace: StoresWrapper: New account store: firstname.lastname@company.de: firstname.lastname@company.de
    2017/04/28 06:25:05.883 (6,): Trace: ZPushAccounts: Checking account: firstname.lastname@company.de
    2017/04/28 06:25:05.883 (6,): Trace: ZPushAccounts: ZPush account: firstname.lastname@company.de
    2017/04/28 06:25:05.889 (6,): Debug: WebApp: Starting kdiscover: company.de
    2017/04/28 06:25:06.428 (6,): Debug: WebApp: Finished kdiscover: company.de: 
    2017/04/28 06:25:06.428 (6,): Info: GAB: Account discovered: firstname lastname
    2017/04/28 06:25:06.505 (6,): Trace: ZPushFolder: Watching folder: firstname.lastname@company.de: 00000000EBA9A36B41584F41BC7ACB0F9F41B1E90100D9539C2261A6BB45B9DAB62C7081B3C101002000FFFF0000
    2017/04/28 06:25:07.568 (6,): Trace: ZPushWatcher: Folder discovered: firstname.lastname@company.de
    2017/04/28 06:25:07.581 (6,): Debug: ZPushWatcher: Folder event: firstname.lastname@company.de, ReplyFlags:MailItem, True
    2017/04/28 06:25:07.956 (6,): Trace: StoresWrapper: New store: Outlook-Datendatei
    2017/04/28 06:25:07.969 (6,): Trace: StoresWrapper: Not an account store: Outlook-Datendatei
    2017/04/28 06:25:07.969 (6,): Debug: GAB: Accounts scanned
    2017/04/28 06:25:07.969 (6,): Debug: ZPushLocalStore: Opening store with prefix C:\Users\mlastname\AppData\Local\Kopano\Kopano OL Extension\KopanoLocalFolders
    2017/04/28 06:25:07.985 (6,): Info: ZPushLocalStore: Opening existing store: C:\Users\mlastname\AppData\Local\Kopano\Kopano OL Extension\KopanoLocalFolders.pst
    2017/04/28 06:25:08.038 (6,): Debug: GAB: CheckGABRemoved
    2017/04/28 06:25:08.044 (6,): Debug: SharedFolders: Starting sync for account firstname.lastname@company.de
    2017/04/28 06:25:08.101 (6,): Trace: ZPushConnection: Request: <?xml version="1.0" encoding="utf-8"?>
    <soap:Envelope xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
        xmlns:xsd="http://www.w3.org/2001/XMLSchema"
        xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"
        xmlns:soap-enc="http://schemas.xmlsoap.org/soap/encoding/"
        xmlns:ns2="http://xml.apache.org/xml-soap"
        xmlns="mail.company.de"
    >
        <soap:Body>
            <AdditionalFolderList>
    <devid xsi:type="xsd:string">d2fcb2678fbf48429115b0b668cb3953</devid>
            </AdditionalFolderList>
        </soap:Body>
    </soap:Envelope>
    2017/04/28 06:29:03.530 (6,): Error: SharedFolders: Exception in task SharedFolders: System.AggregateException: One or more errors occurred. ---> System.Threading.Tasks.TaskCanceledException: A task was canceled.
       --- End of inner exception stack trace ---
       at System.Threading.Tasks.Task.ThrowIfExceptional(Boolean includeTaskCanceledExceptions)
       at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
       at System.Threading.Tasks.Task`1.get_Result()
       at Acacia.ZPush.Connect.ZPushConnection.Execute(String url, RequestEncoder request)
       at Acacia.ZPush.Connect.ZPushWebService.Execute[ResponseType](SoapRequest`1 request)
       at Acacia.ZPush.API.SharedFolders.SharedFoldersAPI.GetCurrentShares(Nullable`1 cancel)
       at Acacia.Features.SharedFolders.SharedFoldersManager.GetCurrentShares(Nullable`1 cancel)
       at Acacia.Features.SharedFolders.FeatureSharedFolders.AdditionalFolders_Sync(ZPushConnection connection)
       at Acacia.ZPush.ZPushSync.SyncTask.<>c__DisplayClass5_0.<GetInstance>b__0()
       at Acacia.Utils.AcaciaTask.Execute()
    ---> (Inner Exception #0) System.Threading.Tasks.TaskCanceledException: A task was canceled.<---
    
    2017/04/28 06:29:03.592 (6,): Trace: Request: Sending request: mail.company.de -> <?xml version="1.0" encoding="utf-16"?><Settings><Oof><Get><BodyType>
        TEXT
       </BodyType></Get></Oof></Settings>
    2017/04/28 06:29:03.592 (6,): Trace: Request: Sending request: mail.company.de -> receiveflags,sendflags,oof,ooftime,sharedfolders,webapp,freebusy,gab,notes,secondarycontacts,sendas,signatures,debugsupport: <?xml version="1.0" encoding="utf-16"?><Settings><Oof><Get><BodyType>
        TEXT
       </BodyType></Get></Oof></Settings>
    2017/04/28 06:32:14.136 (1,VSTA_Main): Trace: ThisAddIn: OutlookUI created
    2017/04/28 06:32:14.286 (1,VSTA_Main): Info: ThisAddIn: Starting version 1.3.156: 343705345b7aef675e2e0a1aa37d011171b6cf2f @ 05.04.2017 12:11:19. Outlook version: 16.0.0.7870. Options: ''
    2017/04/28 06:32:14.286 (1,VSTA_Main): Trace: NLogLogger: Level initialized
    2017/04/28 06:32:14.307 (1,VSTA_Main): Info: FeatureReplyFlags: Starting feature: ''
    2017/04/28 06:32:14.307 (1,VSTA_Main): Trace: FeatureReplyFlags: Started feature
    2017/04/28 06:32:14.307 (1,VSTA_Main): Info: FeatureOutOfOffice: Starting feature: ''
    2017/04/28 06:32:14.314 (1,VSTA_Main): Debug: OutOfOffice: Acacia.UI.Outlook.RibbonToggleButton: Registered
    2017/04/28 06:32:14.314 (1,VSTA_Main): Trace: FeatureOutOfOffice: Started feature
    2017/04/28 06:32:14.314 (1,VSTA_Main): Info: FeatureSharedFolders: Starting feature: ''
    2017/04/28 06:32:14.314 (1,VSTA_Main): Debug: SharedFolders: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:32:14.314 (1,VSTA_Main): Debug: SharedFolders: Acacia.UI.Outlook.MenuItem`1[Acacia.Stubs.IFolder]: Registered
    2017/04/28 06:32:14.314 (1,VSTA_Main): Trace: FeatureSharedFolders: Started feature
    2017/04/28 06:32:14.314 (1,VSTA_Main): Info: FeatureWebApp: Starting feature: ''
    2017/04/28 06:32:14.314 (1,VSTA_Main): Debug: WebApp: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:32:14.314 (1,VSTA_Main): Trace: FeatureWebApp: Started feature
    2017/04/28 06:32:14.314 (1,VSTA_Main): Info: FeatureFreeBusy: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureFreeBusy: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureGAB: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureGAB: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureNotes: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureNotes: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureSecondaryContacts: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureSecondaryContacts: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureSendAs: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureSendAs: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureSignatures: Starting feature: ''
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureSignatures: Started feature
    2017/04/28 06:32:14.333 (1,VSTA_Main): Info: FeatureDebugSupport: Starting feature: 'Dialog'
    2017/04/28 06:32:14.333 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:32:14.333 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:32:14.333 (1,VSTA_Main): Debug: DebugSupport: Acacia.UI.Outlook.RibbonButton: Registered
    2017/04/28 06:32:14.333 (1,VSTA_Main): Trace: FeatureDebugSupport: Started feature
    2017/04/28 06:32:14.373 (1,VSTA_Main): Debug: ThisAddIn: Startup done
    2017/04/28 06:32:14.748 (5,): Trace: StoresWrapper: New store: firstname.lastname@company.de
    2017/04/28 06:32:14.759 (5,): Trace: StoresWrapper: Account registered: firstname lastname -> 0000000038A1BB1005E5101AA1BB08002B2A56C200007073747072782E646C6C0000000000000000E92FEB759650448683B87DE522AA4948000043003A005C00550073006500720073005C006D006E0069006500770069006E0064005C0041007000700044006100740061005C004C006F00630061006C005C004D006900630072006F0073006F00660074005C004F00750074006C006F006F006B005C006D00690063006800610065006C002E006E0069006500770069006E00640040006D0065007400610067006D00620068002E006400650020002D00200054006500730074002E006F00730074000000
    2017/04/28 06:32:14.759 (5,): Trace: StoresWrapper: New account store: firstname.lastname@company.de: firstname.lastname@company.de
    2017/04/28 06:32:14.759 (5,): Trace: ZPushAccounts: Checking account: firstname.lastname@company.de
    2017/04/28 06:32:14.759 (5,): Trace: ZPushAccounts: ZPush account: firstname.lastname@company.de
    2017/04/28 06:32:14.759 (5,): Debug: WebApp: Starting kdiscover: company.de
    2017/04/28 06:32:15.271 (5,): Debug: WebApp: Finished kdiscover: company.de: 
    2017/04/28 06:32:15.271 (5,): Info: GAB: Account discovered: firstname lastname
    2017/04/28 06:32:15.292 (5,): Trace: ZPushFolder: Watching folder: firstname.lastname@company.de: 00000000EBA9A36B41584F41BC7ACB0F9F41B1E90100D9539C2261A6BB45B9DAB62C7081B3C101002000FFFF0000
    2017/04/28 06:32:16.008 (5,): Trace: ZPushWatcher: Folder discovered: firstname.lastname@company.de
    2017/04/28 06:32:16.126 (5,): Debug: ZPushWatcher: Folder event: firstname.lastname@company.de, ReplyFlags:MailItem, True
    2017/04/28 06:32:16.273 (5,): Trace: StoresWrapper: New store: Outlook-Datendatei
    2017/04/28 06:32:16.283 (5,): Trace: StoresWrapper: Not an account store: Outlook-Datendatei
    2017/04/28 06:32:16.283 (5,): Debug: GAB: Accounts scanned
    2017/04/28 06:32:16.283 (5,): Debug: ZPushLocalStore: Opening store with prefix C:\Users\mlastname\AppData\Local\Kopano\Kopano OL Extension\KopanoLocalFolders
    2017/04/28 06:32:16.283 (5,): Info: ZPushLocalStore: Opening existing store: C:\Users\mlastname\AppData\Local\Kopano\Kopano OL Extension\KopanoLocalFolders.pst
    2017/04/28 06:32:16.335 (5,): Debug: GAB: CheckGABRemoved
    2017/04/28 06:32:16.335 (5,): Debug: SharedFolders: Starting sync for account firstname.lastname@company.de
    2017/04/28 06:32:16.401 (5,): Trace: ZPushConnection: Request: <?xml version="1.0" encoding="utf-8"?>
    <soap:Envelope xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
        xmlns:xsd="http://www.w3.org/2001/XMLSchema"
        xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"
        xmlns:soap-enc="http://schemas.xmlsoap.org/soap/encoding/"
        xmlns:ns2="http://xml.apache.org/xml-soap"
        xmlns="mail.company.de"
    >
        <soap:Body>
            <AdditionalFolderList>
    <devid xsi:type="xsd:string">d2fcb2678fbf48429115b0b668cb3953</devid>
            </AdditionalFolderList>
        </soap:Body>
    </soap:Envelope>
    2017/04/28 06:36:16.502 (5,): Error: SharedFolders: Exception in task SharedFolders: System.AggregateException: One or more errors occurred. ---> System.Threading.Tasks.TaskCanceledException: A task was canceled.
       --- End of inner exception stack trace ---
       at System.Threading.Tasks.Task.ThrowIfExceptional(Boolean includeTaskCanceledExceptions)
       at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
       at System.Threading.Tasks.Task`1.get_Result()
       at Acacia.ZPush.Connect.ZPushConnection.Execute(String url, RequestEncoder request)
       at Acacia.ZPush.Connect.ZPushWebService.Execute[ResponseType](SoapRequest`1 request)
       at Acacia.ZPush.API.SharedFolders.SharedFoldersAPI.GetCurrentShares(Nullable`1 cancel)
       at Acacia.Features.SharedFolders.SharedFoldersManager.GetCurrentShares(Nullable`1 cancel)
       at Acacia.Features.SharedFolders.FeatureSharedFolders.AdditionalFolders_Sync(ZPushConnection connection)
       at Acacia.ZPush.ZPushSync.SyncTask.<>c__DisplayClass5_0.<GetInstance>b__0()
       at Acacia.Utils.AcaciaTask.Execute()
    ---> (Inner Exception #0) System.Threading.Tasks.TaskCanceledException: A task was canceled.<---
    
    2017/04/28 06:36:16.576 (5,): Trace: Request: Sending request: mail.company.de -> <?xml version="1.0" encoding="utf-16"?><Settings><Oof><Get><BodyType>
        TEXT
       </BodyType></Get></Oof></Settings>
    2017/04/28 06:36:16.576 (5,): Trace: Request: Sending request: mail.company.de -> receiveflags,sendflags,oof,ooftime,sharedfolders,webapp,freebusy,gab,notes,secondarycontacts,sendas,signatures,debugsupport: <?xml version="1.0" encoding="utf-16"?><Settings><Oof><Get><BodyType>
        TEXT
       </BodyType></Get></Oof></Settings>
    

  • Kopano

    Well, if there is no traffic from Outlook, then it’s hard to say.
    I guess you tried restarting OL and/or rebooting the PC?



  • Of course. :)

    We waited ~2h and now it is in sync again…wired…


  • Kopano

    Perhaps the sync went into loop detection, this can delay the sync substantially.
    But then still, there should have been some movement in the log.


Log in to reply
 

Looks like your connection to Kopano Community Forum was lost, please wait while we try to reconnect.