Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Javascript Error (recRule.getComponent is not a function) #37

Closed
ricleal opened this issue Jan 23, 2018 · 35 comments
Closed

Javascript Error (recRule.getComponent is not a function) #37

ricleal opened this issue Jan 23, 2018 · 35 comments

Comments

@ricleal
Copy link

ricleal commented Jan 23, 2018

Hi!

Great peace of software.
I'm just reporting an issue I'm having synchronising with activesync.

The GUI shows: Calendar : Javascript Error: Check Debug, and the debug console the following:

recRule.getComponent is not a function  calendarsync.js:684
	eas.calendarsync.getWbxmlFromCalendarItem chrome://tbsync/content/provider/eas/calendarsync.js:684:33
	eas.calendarsync.sendLocalChanges< chrome://tbsync/content/provider/eas/calendarsync.js:222:62
	InterpretGeneratorResume self-hosted:1213:8
	next self-hosted:1120:9
	TaskImpl_run resource://gre/modules/Task.jsm:319:42
	bound TaskImpl_run self-hosted:957:17

I hope you can fix that! Let me know if you need further info.
Thanks

@jobisoft
Copy link
Owner

Please retry with beta4 and report, if the error remains

@ricleal
Copy link
Author

ricleal commented Jan 23, 2018

Thanks for the reply!
I installed beta 4 but the problem persists (in a different line):

recRule.getComponent is not a function  sync.js:223
	eas.sync.getItemRecurrence chrome://tbsync/content/provider/eas/sync.js:223:33
	eas.sync.Calendar.getWbxmlFromThunderbirdItem chrome://tbsync/content/provider/eas/calendarsync.js:247:26
	eas.sync.sendLocalChanges< chrome://tbsync/content/provider/eas/sync.js:552:62
	InterpretGeneratorResume self-hosted:1213:8
	next self-hosted:1120:9
	TaskImpl_run resource://gre/modules/Task.jsm:319:42
	bound TaskImpl_run self-hosted:957:17

@jobisoft
Copy link
Owner

hm, that is odd. Can you send me a full debug log? I would like to look at the actual data being processed.

Debug log can be enabled at the help tab in the account manager.

What kind of system/environment is this?

@ChrisJAllan
Copy link
Contributor

ChrisJAllan commented Jan 24, 2018

I think it's an RDATE rule. I've started on something to support it, but there doesn't seem to be any way to make such an event from within Thunderbird or Outlook so I'll have to get creative with the testing.

EDIT:
It doesn't seem that EAS or Outlook supports those kinds on events. (I can't even import the iCal file to Outlook) Should we just ignore those or try to break them into separate events?

@jobisoft
Copy link
Owner

I actually do not know what you are talking about :-)

The error happens while trying to sync something from Thunderbird to the EAS server, right?
@ricleal : How did you get the failing item into your Thunderbird calendar?
@ChrisJAllan : What is RDATE? How do you get the impression, that this could be the reason?

I am officially lost.

@ChrisJAllan
Copy link
Contributor

An RDATE is an exception that adds an extra occurence. I say that this is the issue because that type of recRule does not have a getComponent function and is not filtered out for special handling.

Related, there is also EXRULE, which defines a recurring exception, which isn't checked for or handled correctly. EAS doesn't support either of these rule types, so I was wondering if they should just be ignored.

@jobisoft
Copy link
Owner

@ChrisJAllan So if such events cannot be placed into the TB calendar during the initial sync, the user must have added this event by himself? Can you reproduce that?

If it is not supported by EAS at all, shouldn't we be able to catch those events by

if (recRule.getComponent) {...}

and simply ignore them?

@ricleal Does any of this sound familiar? Did you somehow added an event with exception to your calendar?

@ChrisJAllan
Copy link
Contributor

The only way I found to recreate this was to manually modify an iCal file, import it, and copy the event into the TbSync calendar. PR #38 deals with them.

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

I have no idea. Is there a way I could remove the calendar cache (not all Thunderbird cache) and re-sync everything?

@jobisoft
Copy link
Owner

No, please do not remove anything from your calendar, I will release a new beta shortly. But I have a question:

Your calendar contains a recurring event, which is using a recurrent format that is not supported by EAS. Probably RDATE which adds an "extra" occurence to a series. We ignore this extra occurence. If you ever delete your local thunderbird calendar and than sync the calendar fresh from your server to Thunderbird, that extra occurence will not show up anymore.

TbSync does not have a way to inform users about such things (except the debug log, which logs way to much for everyday usage).

What I could do, is sending you an E-mail notification (to be precise, your EAS server is sending it), that informs you about the situation. Would that be "too much"?

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

That makes sense! I created a recurring event using the Thunderbird calendar...
Sure send me an email: [removed]

@jobisoft
Copy link
Owner

No that is not what I mean. I am thinking about implementing an automatic notification email which is send by TbSync (via your EAS account) to inform you about such a situation. But that is not so important.

Much more interesting is your other remark. Can you recall what exactly you did with that calendar, after you initially synced it down from your server? Did you import anything from an iCal file or did you simply add an recurring event? What kind of recurrence?

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

LOL!
Monday I just simply add an recurring event: bi-weekly, Tuesday at 9AM EST (starting yesterday).

@jobisoft
Copy link
Owner

can you remove that recurring event and try to sync? does it work?
can you than re-add it exactly as you did before and sync again? does it work?

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

I had done that.
Doesn't work. Here you have the full log (Creating and removing the recurring event):

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Init] : Please send this log to john.bieling@XXX.XX, if you have encountered an error.

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Thunderbird] : 52.5.0 on Linux

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[PROVIDER] : eas::Exchange Active Sync

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[PROVIDER] : dav::CalDAV/CardDAV (sabre/dav, ownCloud, Nextcloud)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Default (52.5.0)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : English (GB) Language Pack (52.5.0)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Messaging Menu and Unity Launcher integration (1.3.1)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : ExQuilla for Microsoft Exchange (52.3.1200)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Lightning (5.4)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Thunderbird Conversations (2.13.4)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Markdown Here (2.13.2)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : TbSync (Provider for Exchange ActiveSync) (0.6.9.2-beta4)

** Wed Jan 24 2018 14:27:47 GMT-0500 (EST) **
[Active AddOn] : Shockwave Flash (28.0.0.137)

** Wed Jan 24 2018 14:27:48 GMT-0500 (EST) **
[JavaScript Error: "TypeError: tab is undefined" {file: "chrome://messenger/content/tabmail.xml" line: 1070}]
getBrowserForSelectedTab@chrome://messenger/content/tabmail.xml:1070:15
getBrowser@chrome://messenger/content/mailWindow.js:548:20
messagePaneOnResize@chrome://communicator/content/contentAreaClick.js:60:17
onresize@chrome://messenger/content/messenger.xul:1:8


** Wed Jan 24 2018 14:27:51 GMT-0500 (EST) **
[INIT] : DB

** Wed Jan 24 2018 14:27:53 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: syncing, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: requestingfolders, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 52 3 32 0 1 1

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<SyncKey>2</SyncKey>
</FolderSync>

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[JavaScript Error: "activesync.XXXX.XXX : server does not support RFC 5746, see CVE-2009-3555"]

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 4c 3 31 0 1 52 3 32 0 1 4e 57 3 30 0 1 1 1

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<Status>1</Status>
<SyncKey>2</SyncKey>
<Changes>
<Count>0</Count>
</Changes>
</FolderSync>

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Extracted XML data] : 
FolderSync => 
 Status = [1]
 SyncKey = [2]
 Changes => 
  Count = [0]
 Changes <= 
FolderSync <= 


** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: preparing, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[checkCalender] : 1.74

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: requestingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 30 32 37 39 38 37 33 33 38 0 1 52 3 37 34 0 1 5e 3 31 0 1 53 3 31 0 1 55 3 31 30 30 0 1 57 0 11 45 46 3 31 0 1 1 0 0 1 1 1 1

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>2027987338</SyncKey>
<CollectionId>74</CollectionId>
<DeletesAsMoves>1</DeletesAsMoves>
<GetChanges>1</GetChanges>
<WindowSize>100</WindowSize>
<Options>
<BodyPreference xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
</BodyPreference>
</Options>
</Collection>
</Collections>
</Sync>

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=Sync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 


** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 


** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: recievingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: sendingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[finishFolderSync(rhf@XXXX.XXX.Calendar)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: done, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[finishAccountSync(rhf@XXXX.XXX)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:46:25 GMT-0500 (EST) **
[JavaScript Error: "recRule.getComponent is not a function" {file: "chrome://tbsync/content/provider/eas/sync.js" line: 223}]
eas.sync.getItemRecurrence@chrome://tbsync/content/provider/eas/sync.js:223:33
eas.sync.Calendar.getWbxmlFromThunderbirdItem@chrome://tbsync/content/provider/eas/calendarsync.js:247:26
eas.sync.sendLocalChanges<@chrome://tbsync/content/provider/eas/sync.js:552:62
TaskImpl_run@resource://gre/modules/Task.jsm:319:42


** Wed Jan 24 2018 15:47:30 GMT-0500 (EST) **
[JavaScript Error: "TypeError: getBrowser(...) is null" {file: "chrome://messenger/content/mailWindow.js" line: 62}]
onCopyOrDragStart@chrome://messenger/content/mailWindow.js:62:19


** Wed Jan 24 2018 15:47:32 GMT-0500 (EST) **
[INIT] : DB

** Wed Jan 24 2018 15:47:35 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 15:50:07 GMT-0500 (EST) **
[JavaScript Error: "2018-01-24 15:50:07	gloda.datastore	ERROR	got error in _asyncTrackerListener.handleError(): 19: constraint failed
" {file: "resource:///modules/gloda/log4moz.js" line: 691}]
CApp_append@resource:///modules/gloda/log4moz.js:691:7
Logger_log@resource:///modules/gloda/log4moz.js:380:7
Logger_error@resource:///modules/gloda/log4moz.js:388:5
GlodaDatastore._asyncTrackerListener.handleError@resource:///modules/gloda/datastore.js:1803:9


** Wed Jan 24 2018 15:54:31 GMT-0500 (EST) **
[JavaScript Error: "2018-01-24 15:54:31	gloda.collection	ERROR	caught exception from listener in onItemsModified: resource://conversations/modules/conversation.js:1047: TypeError: markReadButton is null
" {file: "resource:///modules/gloda/log4moz.js" line: 691}]
CApp_append@resource:///modules/gloda/log4moz.js:691:7
Logger_log@resource:///modules/gloda/log4moz.js:380:7
Logger_error@resource:///modules/gloda/log4moz.js:388:5
gloda_coll_onItemsModified@resource:///modules/gloda/collection.js:584:9
gloda_colm_itemsModified@resource:///modules/gloda/collection.js:382:9
gloda_ds_updateMessageLocations@resource:///modules/gloda/datastore.js:2706:7
gloda_indexer_msgsMoveCopyCompleted@resource:///modules/gloda/index_msg.js:2418:15
_finishCopy@jar:file:///home/rhf/.thunderbird/en7zwitk.default/extensions/exquilla@mesquilla.com.xpi!/components/ewsMsgFolderComponent.js:3449:7
EwsMsgFolder.prototype._promiseCopyEwsMessages<@jar:file:///home/rhf/.thunderbird/en7zwitk.default/extensions/exquilla@mesquilla.com.xpi!/components/ewsMsgFolderComponent.js:3433:7
TaskImpl_run@resource://gre/modules/Task.jsm:319:42


** Wed Jan 24 2018 16:19:34 GMT-0500 (EST) **
[setSyncState] : State: syncing, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: requestingfolders, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 52 3 32 0 1 1

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<SyncKey>2</SyncKey>
</FolderSync>

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[JavaScript Error: "activesync.XXXX.XXX : server does not support RFC 5746, see CVE-2009-3555"]

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 4c 3 31 0 1 52 3 32 0 1 4e 57 3 30 0 1 1 1

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<Status>1</Status>
<SyncKey>2</SyncKey>
<Changes>
<Count>0</Count>
</Changes>
</FolderSync>

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Extracted XML data] : 
FolderSync => 
 Status = [1]
 SyncKey = [2]
 Changes => 
  Count = [0]
 Changes <= 
FolderSync <= 


** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: preparing, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[checkCalender] : 1.74

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: requestingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 30 32 37 39 38 37 33 33 38 0 1 52 3 37 34 0 1 5e 3 31 0 1 53 3 31 0 1 55 3 31 30 30 0 1 57 0 11 45 46 3 31 0 1 1 0 0 1 1 1 1

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>2027987338</SyncKey>
<CollectionId>74</CollectionId>
<DeletesAsMoves>1</DeletesAsMoves>
<GetChanges>1</GetChanges>
<WindowSize>100</WindowSize>
<Options>
<BodyPreference xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
</BodyPreference>
</Options>
</Collection>
</Collections>
</Sync>

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=Sync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 


** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 


** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: recievingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: sendingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[finishFolderSync(rhf@XXXX.XXX.Calendar)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: done, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[finishAccountSync(rhf@XXXX.XXX)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:19:35 GMT-0500 (EST) **
[JavaScript Error: "recRule.getComponent is not a function" {file: "chrome://tbsync/content/provider/eas/sync.js" line: 223}]
eas.sync.getItemRecurrence@chrome://tbsync/content/provider/eas/sync.js:223:33
eas.sync.Calendar.getWbxmlFromThunderbirdItem@chrome://tbsync/content/provider/eas/calendarsync.js:247:26
eas.sync.sendLocalChanges<@chrome://tbsync/content/provider/eas/sync.js:552:62
TaskImpl_run@resource://gre/modules/Task.jsm:319:42


** Wed Jan 24 2018 16:19:58 GMT-0500 (EST) **
[JavaScript Error: "NS_ERROR_NOT_AVAILABLE: Cannot call openModalWindow on a hidden window" {file: "resource://gre/components/nsPrompter.js" line: 351}]

** Wed Jan 24 2018 16:19:58 GMT-0500 (EST) **
[JavaScript Error: "NS_ERROR_NOT_AVAILABLE: Cannot call openModalWindow on a hidden window" {file: "resource://gre/components/nsPrompter.js" line: 351}]

** Wed Jan 24 2018 16:19:58 GMT-0500 (EST) **
[JavaScript Error: "NS_ERROR_NOT_AVAILABLE: Cannot call openModalWindow on a hidden window" {file: "resource://gre/components/nsPrompter.js" line: 351}]
openModalWindow@resource://gre/components/nsPrompter.js:351:19
ModalPrompter.prototype.openPrompt@resource://gre/components/nsPrompter.js:579:9
ModalPrompter.prototype.confirmEx@resource://gre/components/nsPrompter.js:720:9
Prompter.prototype.confirmEx@resource://gre/components/nsPrompter.js:79:16
calItipEmailTransport.prototype._sendXpcomMail@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calItipEmailTransport.js:248:21
calItipEmailTransport.prototype.sendItems@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calItipEmailTransport.js:54:24
sendMessage/_sendItem@resource://calendar/modules/calItipUtils.jsm:1147:16
sendMessage@resource://calendar/modules/calItipUtils.jsm:1170:16
cal.itip.checkAndSend@resource://calendar/modules/calItipUtils.jsm:751:21
InvitationsManager.prototype.processJobQueue/operationListener.prototype.onOperationComplete@chrome://calendar/content/calendar-invitations-manager.js:280:21
cal.ProviderBase.prototype.notifyPureOperationComplete@resource://calendar/modules/calProviderUtils.jsm:632:17
cal.ProviderBase.prototype.notifyOperationComplete@resource://calendar/modules/calProviderUtils.jsm:640:9
calStorageCalendar.prototype.doModifyItem@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:567:9
calStorageCalendar.prototype.modifyItem/offlineJournalFlagListener.onOperationComplete@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:477:17
calStorageCalendar.prototype.getItemOfflineFlag/listener.handleCompletion@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:959:21
openModalWindow@resource://gre/components/nsPrompter.js:364:5
ModalPrompter.prototype.openPrompt@resource://gre/components/nsPrompter.js:579:9
ModalPrompter.prototype.confirmEx@resource://gre/components/nsPrompter.js:720:9
Prompter.prototype.confirmEx@resource://gre/components/nsPrompter.js:79:16
calItipEmailTransport.prototype._sendXpcomMail@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calItipEmailTransport.js:248:21
calItipEmailTransport.prototype.sendItems@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calItipEmailTransport.js:54:24
sendMessage/_sendItem@resource://calendar/modules/calItipUtils.jsm:1147:16
sendMessage@resource://calendar/modules/calItipUtils.jsm:1170:16
cal.itip.checkAndSend@resource://calendar/modules/calItipUtils.jsm:751:21
InvitationsManager.prototype.processJobQueue/operationListener.prototype.onOperationComplete@chrome://calendar/content/calendar-invitations-manager.js:280:21
cal.ProviderBase.prototype.notifyPureOperationComplete@resource://calendar/modules/calProviderUtils.jsm:632:17
cal.ProviderBase.prototype.notifyOperationComplete@resource://calendar/modules/calProviderUtils.jsm:640:9
calStorageCalendar.prototype.doModifyItem@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:567:9
calStorageCalendar.prototype.modifyItem/offlineJournalFlagListener.onOperationComplete@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:477:17
calStorageCalendar.prototype.getItemOfflineFlag/listener.handleCompletion@file:///home/rhf/.thunderbird/en7zwitk.default/extensions/%7Be2fda1a4-762b-4020-b5ad-a41df1933103%7D/components/calStorageCalendar.js:959:21


** Wed Jan 24 2018 16:19:58 GMT-0500 (EST) **
[JavaScript Error: "[Exception... "Cannot call openModalWindow on a hidden window"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: resource://gre/components/nsPrompter.js :: openModalWindow :: line 351"  data: no]" {file: "resource://calendar/modules/calProviderUtils.jsm" line: 634}]

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: syncing, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: requestingfolders, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 52 3 32 0 1 1

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<SyncKey>2</SyncKey>
</FolderSync>

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 4c 3 31 0 1 52 3 32 0 1 4e 57 3 30 0 1 1 1

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<Status>1</Status>
<SyncKey>2</SyncKey>
<Changes>
<Count>0</Count>
</Changes>
</FolderSync>

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Extracted XML data] : 
FolderSync => 
 Status = [1]
 SyncKey = [2]
 Changes => 
  Count = [0]
 Changes <= 
FolderSync <= 


** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: preparing, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[checkCalender] : 1.74

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: requestingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 30 32 37 39 38 37 33 33 38 0 1 52 3 37 34 0 1 5e 3 31 0 1 53 3 31 0 1 55 3 31 30 30 0 1 57 0 11 45 46 3 31 0 1 1 0 0 1 1 1 1

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>2027987338</SyncKey>
<CollectionId>74</CollectionId>
<DeletesAsMoves>1</DeletesAsMoves>
<GetChanges>1</GetChanges>
<WindowSize>100</WindowSize>
<Options>
<BodyPreference xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
</BodyPreference>
</Options>
</Collection>
</Collections>
</Sync>

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=Sync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 


** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 


** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: recievingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: sendingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[finishFolderSync(rhf@XXXX.XXX.Calendar)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: done, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[finishAccountSync(rhf@XXXX.XXX)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:20:11 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:20:12 GMT-0500 (EST) **
[JavaScript Error: "recRule.getComponent is not a function" {file: "chrome://tbsync/content/provider/eas/sync.js" line: 223}]
eas.sync.getItemRecurrence@chrome://tbsync/content/provider/eas/sync.js:223:33
eas.sync.Calendar.getWbxmlFromThunderbirdItem@chrome://tbsync/content/provider/eas/calendarsync.js:247:26
eas.sync.sendLocalChanges<@chrome://tbsync/content/provider/eas/sync.js:552:62
TaskImpl_run@resource://gre/modules/Task.jsm:319:42


** Wed Jan 24 2018 16:21:43 GMT-0500 (EST) **
[JavaScript Error: "2018-01-24 16:21:43.600	exquilla.native	ERROR	machine error: taskCopyItems responseCode:taskCopyItems aMessageText: <javascript error: 2147942487
 line: undefined 
JS frame :: resource://exquilla/ewsUtils.jsm :: se :: line 85 
JS frame :: resource://exquilla/EwsNativeMachine.jsm :: taskCopyItems :: line 518 
JS frame :: resource://gre/modules/Task.jsm :: TaskImpl_run :: line 336 
>" {file: "resource://gre/modules/Log.jsm" line: 753}]
App_append@resource://gre/modules/Log.jsm:753:9
Logger.prototype.log@resource://gre/modules/Log.jsm:389:7
Logger.prototype.error@resource://gre/modules/Log.jsm:397:5
_machineErrorResponse@resource://exquilla/EwsNativeMachine.jsm:1982:5
taskCopyItems@resource://exquilla/EwsNativeMachine.jsm:518:18
TaskImpl_run@resource://gre/modules/Task.jsm:336:41


** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: syncing, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: requestingfolders, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 52 3 32 0 1 1

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Sending data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<SyncKey>2</SyncKey>
</FolderSync>

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[JavaScript Error: "activesync.XXXX.XXX : server does not support RFC 5746, see CVE-2009-3555"]

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (WBXML)] : 
3 1 6a 0 0 7 56 4c 3 31 0 1 52 3 32 0 1 4e 57 3 30 0 1 1 1

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Receiving data <requestingfolders> for rhf@XXXX.XXX (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<Status>1</Status>
<SyncKey>2</SyncKey>
<Changes>
<Count>0</Count>
</Changes>
</FolderSync>

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Extracted XML data] : 
FolderSync => 
 Status = [1]
 SyncKey = [2]
 Changes => 
  Count = [0]
 Changes <= 
FolderSync <= 


** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: preparing, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[checkCalender] : 1.74

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: requestingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 30 32 37 39 38 37 33 33 38 0 1 52 3 37 34 0 1 5e 3 31 0 1 53 3 31 0 1 55 3 31 30 30 0 1 57 0 11 45 46 3 31 0 1 1 0 0 1 1 1 1

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Sending data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>2027987338</SyncKey>
<CollectionId>74</CollectionId>
<DeletesAsMoves>1</DeletesAsMoves>
<GetChanges>1</GetChanges>
<WindowSize>100</WindowSize>
<Options>
<BodyPreference xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
</BodyPreference>
</Options>
</Collection>
</Collections>
</Sync>

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=Sync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 


** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[Receiving data <requestingchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 


** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: recievingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: sendingchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[finishFolderSync(rhf@XXXX.XXX.Calendar)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: done, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[finishAccountSync(rhf@XXXX.XXX)] : Javascript error! Check debug log for details.

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 16:26:44 GMT-0500 (EST) **
[JavaScript Error: "recRule.getComponent is not a function" {file: "chrome://tbsync/content/provider/eas/sync.js" line: 223}]
eas.sync.getItemRecurrence@chrome://tbsync/content/provider/eas/sync.js:223:33
eas.sync.Calendar.getWbxmlFromThunderbirdItem@chrome://tbsync/content/provider/eas/calendarsync.js:247:26
eas.sync.sendLocalChanges<@chrome://tbsync/content/provider/eas/sync.js:552:62
TaskImpl_run@resource://gre/modules/Task.jsm:319:42


@jobisoft
Copy link
Owner

Please try again with beta7.

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

It fails with a different message..

image

Here's the log (removed attendees and text):

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Init] : Please send this log to john.bieling@gmx.de, if you have encountered an error.

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Thunderbird] : 52.5.0 on Linux

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[PROVIDER] : eas::Exchange Active Sync

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[PROVIDER] : dav::CalDAV/CardDAV (sabre/dav, ownCloud, Nextcloud)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Default (52.5.0)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : English (GB) Language Pack (52.5.0)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Messaging Menu and Unity Launcher integration (1.3.1)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : ExQuilla for Microsoft Exchange (52.3.1200)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Lightning (5.4)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Thunderbird Conversations (2.13.4)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Markdown Here (2.13.2)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : TbSync (Provider for Exchange ActiveSync) (0.6.9.2-beta7)

** Wed Jan 24 2018 17:08:43 GMT-0500 (EST) **
[Active AddOn] : Shockwave Flash (28.0.0.137)

[....]

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[setSyncState] : State: prepare.request.localchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Ignoring rule] : RDATE;VALUE=DATE-TIME:20180118T200000Z


** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[setSyncState] : State: send.request.localchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Sending data <send.request.localchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 

(**************)

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Sending data <send.request.localchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>2027987338</SyncKey>
<CollectionId>74</CollectionId>
<Commands>
<Add>
<ClientId>040000008200E00074C5B7101A82E0080000000030A4DCBCB557D301000000000000000010000000F7F0AEF2E6892E42B4201E3E1171E65B</ClientId>
<ApplicationData>
<UID xmlns='Calendar'>040000008200E00074C5B7101A82E0080000000030A4DCBCB557D301000000000000000010000000F7F0AEF2E6892E42B4201E3E1171E65B</UID>
<TimeZone xmlns='Calendar'>LAEAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</TimeZone>
<StartTime xmlns='Calendar'>20180118T200000Z</StartTime>
<EndTime xmlns='Calendar'>20180118T200000Z</EndTime>
<DtStamp xmlns='Calendar'>20180117T163310Z</DtStamp>
<Subject xmlns='Calendar'/>
<Location xmlns='Calendar'/>
<Categories xmlns='Calendar'/>
<Attendees xmlns='Calendar'/>
<Exceptions xmlns='Calendar'>
<Exception xmlns='Calendar'>
<ExceptionStartTime xmlns='Calendar'>20180118T200000Z</ExceptionStartTime>
<StartTime xmlns='Calendar'>20180118T200000Z</StartTime>
<EndTime xmlns='Calendar'>20180118T210000Z</EndTime>
<DtStamp xmlns='Calendar'>20180117T163343Z</DtStamp>
<Subject xmlns='Calendar'>Monthly Meeting for the ECS initiative</Subject>
<Location xmlns='Calendar'>RES: CR 8600 RM C464 (Polycom)</Location>

<Body xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
<EstimatedDataSize xmlns='AirSyncBase'>130</EstimatedDataSize>
<Data xmlns='AirSyncBase'>Hi all:
The next meeting for the ECS initiative is scheduled for tomorrow from 3 � 4 PM at the SNS in room 464.

Regards,
Adam

</Data>
</Body>
<BusyStatus xmlns='Calendar'>2</BusyStatus>
<Sensitivity xmlns='Calendar'>0</Sensitivity>
<AllDayEvent xmlns='Calendar'>0</AllDayEvent>
<MeetingStatus xmlns='Calendar'>3</MeetingStatus>
</Exception>
</Exceptions>
<Body xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
<EstimatedDataSize xmlns='AirSyncBase'>0</EstimatedDataSize>
<Data xmlns='AirSyncBase'/>
</Body>
<BusyStatus xmlns='Calendar'>1</BusyStatus>
<Sensitivity xmlns='Calendar'>1</Sensitivity>
<AllDayEvent xmlns='Calendar'>0</AllDayEvent>
<MeetingStatus xmlns='Calendar'>1</MeetingStatus>
</ApplicationData>
</Add>

[...]

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[sending] : POST https://activesync.XXXX.XXX/Microsoft-Server-ActiveSync?Cmd=Sync&User=rhf%40XXXX.XXX&DeviceType=Thunderbird&DeviceId=mztb10c6ce77f6b99007bfc3fd28fe6b

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[PolicyKey used] : 929673007

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Receiving data <send.request.localchanges> for rhf@XXXX.XXX (Calendar) (WBXML)] : 
3 1 6a 0 45 4e 3 34 0 1 1

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Receiving data <send.request.localchanges> for rhf@XXXX.XXX (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Status>4</Status>
</Sync>

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[setSyncState] : State: eval.response.localchanges, Account: rhf@XXXX.XXX, Folder: Calendar

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[Extracted XML data] : 
Sync => 
 Status = [4]
Sync <= 


** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[wbxml status check] : Sync: Sync.Status = 4

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[wbxml status] : Server reports unhandled status <Sync.Status = 4>. Aborting Sync.

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[finishFolderSync(rhf@XXXX.XXX.Calendar)] : Sync failed. Server responds with status <Sync.Status = 4>.

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[setSyncState] : State: done, Account: rhf@XXXX.XXX

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[finishAccountSync(rhf@XXXX.XXX)] : Sync failed. Server responds with status <Sync.Status = 4>.

** Wed Jan 24 2018 17:08:58 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: rhf@XXXX.XXX

@jobisoft
Copy link
Owner

Why is he trying to add tons of new items to the server, if you just changed one? Can you please start from scratch? Disconnect account and reconnect. And than make a change to the calendar and sync.

@ChrisJAllan
Copy link
Contributor

ChrisJAllan commented Jan 24, 2018

The event on 2018-01-18 (Monthly Meeting for the ECS initiative) is the issue. It doesn't have a recurrence rule, only a date (which is ignored), and then an exception for that event, which fails as there is no recurrence to modify. I have no idea how an event ended up this mangled or how to deal with it. Was that one created in Thunderbird or somewhere else?

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

It works now :) Disconnected the account and reconnected it again. I didn't do it before because I thought that I would lost the cache (12h synchronising all the stuff...).
No more duplicated stuff...
Thanks! Looks like it's up and running.

@jobisoft
Copy link
Owner

@ricleal Can you re-add the event with the recurrence we are talking about? What happens if you try to sync after that?

@ChrisJAllan
Copy link
Contributor

@ricleal Does that event actually occur monthly? There doesn't seem to be any monthly rule on it. It seems the best solution would be to delete and re-create that event.

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

If I create a bi-weekly event I have the same problem :(


** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[wbxml status check] : Sync: Sync.Collections.Collection.Responses.Add[0].Status = 6

** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[wbxml status] : Server reports unhandled status <Sync.Collections.Collection.Responses.Add[0].Status = 6>. Aborting Sync.

** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[finishFolderSync(ORNL.Calendar)] : Sync failed. Server responds with status <Sync.Collections.Collection.Responses.Add[0].Status = 6>.

** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[setSyncState] : State: done, Account: ORNL

** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[finishAccountSync(ORNL)] : Sync failed. Server responds with status <Sync.Collections.Collection.Responses.Add[0].Status = 6>.

** Wed Jan 24 2018 17:41:26 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: XXX

@jobisoft
Copy link
Owner

full log please

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

Monthly is OK!

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

Don't ask me why, it works now with bi-weekly, weekly, etc...

@jobisoft
Copy link
Owner

no, that is a bug in tbSync. After he failed to sync the "bad" event, he forgets about it and next time you sync, he does not include it. But it has not yet been synced

Please start from scratch again, add a bi-weekly meeting. Restart TB (to clear the log) and sync and send the full log of the error.

@ChrisJAllan
Copy link
Contributor

Make sure it actually shows up on the remote server before saying "it works."

@ricleal
Copy link
Author

ricleal commented Jan 24, 2018

I can't repeat the error. everything is OK. The remote calendar is updated after the synchronisation for any type of recurring events. I will update this issue if the problem arises again.

@jobisoft
Copy link
Owner

jobisoft commented Jan 24, 2018

I am not able to reproduce the bad event stated in the log, starting from a be-weekly recurrence pattern. This is so strange...

Repository owner deleted a comment from ricleal Jan 24, 2018
@jobisoft jobisoft changed the title Javascript error Javascript Error (recRule.getComponent is not a function) Jan 25, 2018
jobisoft added a commit that referenced this issue Jan 25, 2018
do not add exceptions tag, if we have not added a recurrence tag
@jobisoft
Copy link
Owner

Please update to beta1, it contains a few more sanity check.

@jobisoft
Copy link
Owner

jobisoft commented Jan 26, 2018

Can this issue be considered as solved?

@ricleal
Copy link
Author

ricleal commented Jan 26, 2018

I have had no further issues. From my side yes, you can close the issue.
Thanks again for everything!

@ricleal
Copy link
Author

ricleal commented Feb 1, 2018

Sorry to open this again..
The error came back with a new event... Here the debug:

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Init] : Please send this log to john.bieling@gmx.de, if you have encountered an error.

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Thunderbird] : 52.6.0 on Linux

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[PROVIDER] : eas::Exchange Active Sync

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[PROVIDER] : dav::CalDAV/CardDAV (sabre/dav, ownCloud, Nextcloud)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : ExQuilla for Microsoft Exchange (52.3.1200)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Lightning (5.4)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Thunderbird Conversations (2.13.4)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Markdown Here (2.13.2)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : TbSync (Provider for Exchange ActiveSync) (0.7.3)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Default (52.6.0)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : English (GB) Language Pack (52.6.0)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Messaging Menu and Unity Launcher integration (1.3.1)

** Thu Feb 01 2018 16:58:29 GMT-0500 (EST) **
[Active AddOn] : Shockwave Flash (28.0.0.137)

** Thu Feb 01 2018 16:58:32 GMT-0500 (EST) **
[JavaScript Error: "TypeError: tab is undefined" {file: "chrome://messenger/content/tabmail.xml" line: 1070}]
getBrowserForSelectedTab@chrome://messenger/content/tabmail.xml:1070:15
getBrowser@chrome://messenger/content/mailWindow.js:548:20
messagePaneOnResize@chrome://communicator/content/contentAreaClick.js:60:17
onresize@chrome://messenger/content/messenger.xul:1:8


** Thu Feb 01 2018 16:58:35 GMT-0500 (EST) **
[TbSync init] : start

** Thu Feb 01 2018 16:58:35 GMT-0500 (EST) **
[INIT] : DB

** Thu Feb 01 2018 16:58:37 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: xxxx

** Thu Feb 01 2018 16:58:37 GMT-0500 (EST) **
[TbSync init] : done

** Thu Feb 01 2018 16:58:56 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <calendar-main-default> changed from <true> to <false>

** Thu Feb 01 2018 16:58:56 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <calendar-main-default> changed from <null> to <true>

** Thu Feb 01 2018 16:58:58 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <calendar-main-default> changed from <true> to <false>

** Thu Feb 01 2018 16:58:58 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <calendar-main-default> changed from <null> to <true>

** Thu Feb 01 2018 16:59:10 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <imip.identity.key> changed from <> to <id2>

** Thu Feb 01 2018 16:59:10 GMT-0500 (EST) **
[calendarObserver::onPropertyChanged] : <auto-enabled> changed from <true> to <false>

** Thu Feb 01 2018 16:59:19 GMT-0500 (EST) **
[JavaScript Error: "uncaught exception: 2147500033" {file: "jar:file:///home/xxx/.thunderbird/en7zwitk.default/extensions/exquilla@mesquilla.com.xpi!/components/ewsProtocolComponent.js" line: 788}]

** Thu Feb 01 2018 16:59:19 GMT-0500 (EST) **
[JavaScript Error: "uncaught exception: 2147500033" {file: "jar:file:///home/xxx/.thunderbird/en7zwitk.default/extensions/exquilla@mesquilla.com.xpi!/components/ewsProtocolComponent.js" line: 788}]

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: syncing, Account: xxxx

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: prepare.request.folders, Account: xxxx

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: send.request.folders, Account: xxxx

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending data <send.request.folders> for xxxx (WBXML)] : 
3 1 6a 0 0 7 56 52 3 31 0 1 1

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending data <send.request.folders> for xxxx (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<SyncKey>1</SyncKey>
</FolderSync>

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending (EAS v14.0)] : POST https://activesync.xxxx.gov/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=xxx%40xxxx.gov&DeviceType=Thunderbird&DeviceId=mztba276ee3b44ccc04b854f907959f2

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[JavaScript Error: "activesync.xxxx.gov : server does not support RFC 5746, see CVE-2009-3555"]

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Receiving data <send.request.folders> for xxxx (WBXML)] : 
3 1 6a 0 0 7 56 4c 3 31 0 1 52 3 31 0 1 4e 57 3 30 0 1 1 1

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Receiving data <send.request.folders> for xxxx (XML)] : 
<?xml version="1.0"?>
<FolderSync xmlns='FolderHierarchy'>
<Status>1</Status>
<SyncKey>1</SyncKey>
<Changes>
<Count>0</Count>
</Changes>
</FolderSync>

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: eval.response.folders, Account: xxxx

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Extracted XML data] : 
FolderSync => 
 Status = [1]
 SyncKey = [1]
 Changes => 
  Count = [0]
 Changes <= 
FolderSync <= 


** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: preparing, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[checkCalender] : 2.77

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: prepare.request.estimate, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[setSyncState] : State: send.request.estimate, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending data <send.request.estimate> for xxxx (Calendar) (WBXML)] : 
3 1 6a 0 0 6 45 47 48 0 0 4b 3 32 37 32 36 36 34 39 37 32 0 1 0 6 4a 3 37 37 0 1 0 0 57 50 3 43 61 6c 65 6e 64 61 72 0 1 58 3 37 0 1 1 0 6 1 1 1

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending data <send.request.estimate> for xxxx (Calendar) (XML)] : 
<?xml version="1.0"?>
<GetItemEstimate xmlns='GetItemEstimate'>
<Collections>
<Collection>
<SyncKey xmlns='AirSync'>272664972</SyncKey>
<CollectionId>77</CollectionId>
<Options xmlns='AirSync'>
<Class xmlns='AirSync'>Calendar</Class>
<FilterType xmlns='AirSync'>7</FilterType>
</Options>
</Collection>
</Collections>
</GetItemEstimate>

** Thu Feb 01 2018 17:00:48 GMT-0500 (EST) **
[Sending (EAS v14.0)] : POST https://activesync.xxxx.gov/Microsoft-Server-ActiveSync?Cmd=GetItemEstimate&User=xxx%40xxxx.gov&DeviceType=Thunderbird&DeviceId=mztba276ee3b44ccc04b854f907959f2

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.estimate> for xxxx (Calendar) (WBXML)] : 
3 1 6a 0 0 6 45 4d 4e 3 31 0 1 48 4a 3 37 37 0 1 4c 3 30 0 1 1 1 1

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.estimate> for xxxx (Calendar) (XML)] : 
<?xml version="1.0"?>
<GetItemEstimate xmlns='GetItemEstimate'>
<Response>
<Status>1</Status>
<Collection>
<CollectionId>77</CollectionId>
<Estimate>0</Estimate>
</Collection>
</Response>
</GetItemEstimate>

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: eval.response.estimate, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Extracted XML data] : 
GetItemEstimate => 
 Response => 
  Status = [1]
  Collection => 
   CollectionId = [77]
   Estimate = [0]
  Collection <= 
 Response <= 
GetItemEstimate <= 


** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: prepare.request.remotechanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: send.request.remotechanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending data <send.request.remotechanges> for xxxx (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 37 32 36 36 34 39 37 32 0 1 52 3 37 37 0 1 5e 3 31 0 1 53 3 31 0 1 55 3 35 30 0 1 57 58 3 37 0 1 0 11 45 46 3 31 0 1 1 0 0 1 1 1 1

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending data <send.request.remotechanges> for xxxx (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>272664972</SyncKey>
<CollectionId>77</CollectionId>
<DeletesAsMoves>1</DeletesAsMoves>
<GetChanges>1</GetChanges>
<WindowSize>50</WindowSize>
<Options>
<FilterType>7</FilterType>
<BodyPreference xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
</BodyPreference>
</Options>
</Collection>
</Collections>
</Sync>

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending (EAS v14.0)] : POST https://activesync.xxxx.gov/Microsoft-Server-ActiveSync?Cmd=Sync&User=xxx%40xxxx.gov&DeviceType=Thunderbird&DeviceId=mztba276ee3b44ccc04b854f907959f2

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.remotechanges> for xxxx (Calendar) (WBXML)] : 


** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.remotechanges> for xxxx (Calendar) (XML)] : 


** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: eval.response.remotechanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: prepare.request.localchanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: send.request.localchanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending data <send.request.localchanges> for xxxx (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 37 32 36 36 34 39 37 32 0 1 52 3 37 37 0 1 56 47 4c 3 30 34 30 30 30 30 30 30 38 32 30 30 45 0 1 64 3 31 30 0 1 58 3 33 0 1 0 0 1 1 1 1 1 1

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending data <send.request.localchanges> for xxxx (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>272664972</SyncKey>
<CollectionId>77</CollectionId>
<Commands>
<Add>
<ClientId>040000008200E00074C5B7101A82E00800000000F0B1A952789BD3010000000000000000100000001CFCB99C99B653459AD7A37F03F29C61</ClientId>
<ApplicationData>
<UID xmlns='Calendar'>040000008200E00074C5B7101A82E00800000000F0B1A952789BD3010000000000000000100000001CFCB99C99B653459AD7A37F03F29C61</UID>
<TimeZone xmlns='Calendar'>LAEAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</TimeZone>
<StartTime xmlns='Calendar'>20180207T140000Z</StartTime>
<EndTime xmlns='Calendar'>20180207T150000Z</EndTime>
<DtStamp xmlns='Calendar'>20180201T215922Z</DtStamp>
<Subject xmlns='Calendar'>NScD Data Assessment--Neutron Data Sciences Staff and Peter Parker</Subject>
<Location xmlns='Calendar'>8600, C152</Location>
<Categories xmlns='Calendar'/>
<OrganizerName xmlns='Calendar'>Sawyer, Titonia K.</OrganizerName>
<OrganizerEmail xmlns='Calendar'>sawyertk@xxxx.gov</OrganizerEmail>
<Attendees xmlns='Calendar'>

</Attendees>
<Body xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
<EstimatedDataSize xmlns='AirSyncBase'>1</EstimatedDataSize>
<Data xmlns='AirSyncBase'>
</Data>
</Body>
<BusyStatus xmlns='Calendar'>2</BusyStatus>
<Sensitivity xmlns='Calendar'>0</Sensitivity>
<AllDayEvent xmlns='Calendar'>0</AllDayEvent>
<Reminder xmlns='Calendar'>10</Reminder>
<MeetingStatus xmlns='Calendar'>3</MeetingStatus>
</ApplicationData>
</Add>
<Add>
<ClientId>040000008200E00074C5B7101A82E00800000000F0E85E9E779BD30100000000000000001000000089ABF6F6A3CC4E4CB3FD2D24F8EC2478</ClientId>
<ApplicationData>
<UID xmlns='Calendar'>040000008200E00074C5B7101A82E00800000000F0E85E9E779BD30100000000000000001000000089ABF6F6A3CC4E4CB3FD2D24F8EC2478</UID>
<TimeZone xmlns='Calendar'>LAEAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAACgARwBNAFQALQAwADUAOgAwADAAKQAgAEEAbQBlAHIAaQBjAGEALwBOAGUAdwBfAFkAbwByAGsAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</TimeZone>
<StartTime xmlns='Calendar'>20180206T230000Z</StartTime>
<EndTime xmlns='Calendar'>20180207T010000Z</EndTime>
<DtStamp xmlns='Calendar'>20180201T215946Z</DtStamp>
<Subject xmlns='Calendar'>FW: NScD Data Assessment Poster Session</Subject>
<Location xmlns='Calendar'>8600, Lobby</Location>
<Categories xmlns='Calendar'/>
<OrganizerName xmlns='Calendar'>S.</OrganizerName>
<OrganizerEmail xmlns='Calendar'>sawyertk@xxxx.gov</OrganizerEmail>
<Attendees xmlns='Calendar'>
<Attendee xmlns='Calendar'>
<Email xmlns='Calendar'>parkerpg@xxxx.gov</Email>
<Name xmlns='Calendar'>.</Name>
<AttendeeType xmlns='Calendar'>1</AttendeeType>
</Attendee>
<Attendee xmlns='Calendar'>
<Email xmlns='Calendar'>ferrazlealrm@xxxx.gov</Email>
<Name xmlns='Calendar'></Name>
<AttendeeType xmlns='Calendar'>1</AttendeeType>
</Attendee>
</Attendees>
<Body xmlns='AirSyncBase'>
<Type xmlns='AirSyncBase'>1</Type>
<EstimatedDataSize xmlns='AirSyncBase'>2346</EstimatedDataSize>
<Data xmlns='AirSyncBase'>
[id:image001.png@01D3442D.9C93B7E0]

From: "Sawyer, Titonia K." <sawyertk@xxxx.gov>
Date: Thursday, February 1, 2018 at 4:13 PM
To: 
Subject: NScD Data Assessment Poster Session

From: 
Sent: Monday, January 29, 2018 10:16 AM


</Data>
</Body>
<BusyStatus xmlns='Calendar'>2</BusyStatus>
<Sensitivity xmlns='Calendar'>0</Sensitivity>
<AllDayEvent xmlns='Calendar'>0</AllDayEvent>
<Reminder xmlns='Calendar'>10</Reminder>
<MeetingStatus xmlns='Calendar'>3</MeetingStatus>
</ApplicationData>
</Add>
</Commands>
</Collection>
</Collections>
</Sync>

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Sending (EAS v14.0)] : POST https://activesync.xxxx.gov/Microsoft-Server-ActiveSync?Cmd=Sync&User=xxx%40xxxx.gov&DeviceType=Thunderbird&DeviceId=mztba276ee3b44ccc04b854f907959f2

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.localchanges> for xxxx (Calendar) (WBXML)] : 
3 1 6a 0 45 5c 4f 4b 3 32 37 32 36 36 34 39 37 32 0 1 52 3 37 37 0 1 4e 3 31 0 1 46 47 4c 3 30 34 30 30 30 30 30 30 38 32 30 30 45 30 30 30 37 34 43 35 42 37 31 30 31 41 38 32 45 30 30 38 30 30 30 30 30 30 30 30 46 30 42 31 41 39 35 32 37 38 39 42 44 33 30 31 30 30 30 30 30 30 30 30 30 30 30 30 30 30 30 30 31 30 30 30 30 30 30 30 31 43 46 43 42 39 39 43 39 39 42 36 35 33 34 35 39 41 44 37 41 33 37 46 30 33 46 32 39 43 36 31 0 1 4e 3 36 0 1 1 47 4c 3 30 34 30 30 30 30 30 30 38 32 30 30 45 30 30 30 37 34 43 35 42 37 31 30 31 41 38 32 45 30 30 38 30 30 30 30 30 30 30 30 46 30 45 38 35 45 39 45 37 37 39 42 44 33 30 31 30 30 30 30 30 30 30 30 30 30 30 30 30 30 30 30 31 30 30 30 30 30 30 30 38 39 41 42 46 36 46 36 41 33 43 43 34 45 34 43 42 33 46 44 32 44 32 34 46 38 45 43 32 34 37 38 0 1 4e 3 36 0 1 1 1 1 1 1

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Receiving data <send.request.localchanges> for xxxx (Calendar) (XML)] : 
<?xml version="1.0"?>
<Sync xmlns='AirSync'>
<Collections>
<Collection>
<SyncKey>272664972</SyncKey>
<CollectionId>77</CollectionId>
<Status>1</Status>
<Responses>
<Add>
<ClientId>040000008200E00074C5B7101A82E00800000000F0B1A952789BD3010000000000000000100000001CFCB99C99B653459AD7A37F03F29C61</ClientId>
<Status>6</Status>
</Add>
<Add>
<ClientId>040000008200E00074C5B7101A82E00800000000F0E85E9E779BD30100000000000000001000000089ABF6F6A3CC4E4CB3FD2D24F8EC2478</ClientId>
<Status>6</Status>
</Add>
</Responses>
</Collection>
</Collections>
</Sync>

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: eval.response.localchanges, Account: xxxx, Folder: Calendar

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[Extracted XML data] : 
Sync => 
 Collections => 
  Collection => 
   SyncKey = [272664972]
   CollectionId = [77]
   Status = [1]
   Responses => 
    Add => 
     0 => 
      ClientId = [040000008200E00074C5B7101A82E00800000000F0B1A952789BD3010000000000000000100000001CFCB99C99B653459AD7A37F03F29C61]
      Status = [6]
     0 <= 
     1 => 
      ClientId = [040000008200E00074C5B7101A82E00800000000F0E85E9E779BD30100000000000000001000000089ABF6F6A3CC4E4CB3FD2D24F8EC2478]
      Status = [6]
     1 <= 
    Add <= 
   Responses <= 
  Collection <= 
 Collections <= 
Sync <= 


** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[wbxml status check] : Sync: Sync.Collections.Collection.Responses.Add[0].Status = 6

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[wbxml status] : Server reports unhandled status <Sync.Collections.Collection.Responses.Add[0].Status = 6>. Aborting Sync.

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[finishFolderSync(xxxx.Calendar)] : Sync failed. Server responds with status <Sync.Collections.Collection.Responses.Add[0].Status = 6>.

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: done, Account: xxxx

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[finishAccountSync(xxxx)] : Sync failed. Server responds with status <Sync.Collections.Collection.Responses.Add[0].Status = 6>.

** Thu Feb 01 2018 17:00:49 GMT-0500 (EST) **
[setSyncState] : State: accountdone, Account: xxxx

@jobisoft
Copy link
Owner

jobisoft commented Feb 1, 2018

That is a different error, I do not see any reference to recRule.getComponent. Please open a new issue for this. You do not need to include the log again

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

3 participants