BES duplicates sent messages on device.

AlexanderP · #1 (**permalink**) 04-05-2011, 07:14 AM

Hi guys,
I've recently encountered a problem with my BES. When user seding a message from a device, BES creates 2 copies of it in sent items on device. In mail program, however, it shows only 1 (original) message.
My BES version is 5.0.2 with MR3, my mail system is Exchange 2010.
Here's the sample of MAGT log where you can see both messages. RefID 2032364841 is the sent original, RefID -1136912023 is the copy what BES creates.

Code:

[30112] (04/05 13:28:31.360):{0x1E68} {user@domain.com} Receiving message from device, RefId=2032364841, Tag=4846, TransactionId=-224996249, Date=05.04.2011 13:27:24
[40292] (04/05 13:28:31.610):{0x1E68} {user@domain.com} Email message sent for device, Tag=4846
[40279] (04/05 13:28:31.610):{0x1E68} {user@domain.com} SubmitToRelaySendQ, Tag=4846
[40000] (04/05 13:28:31.610):{0x1328} [BIPP] Send status DATA_ACCEPTED, Tag=4846
[30247] (04/05 13:28:54.966):{0x12DC} Server stats - Msgs: Forwarded 1219, Sent 127, Pending 0, Expired 0, Filtered 29, Forwarded/Min 0, Sent/Min 0
[40856] (04/05 13:29:09.573):{0x1E78} {user2@domain.com} Starting Memos rescan
[40891] (04/05 13:29:09.573):{0x1E78} {user2@domain.com} No changes detected, rescan complete (type=Memos)
[40000] (04/05 13:29:15.525):{0x1324} [BIPP] Received datagram, Tag=4847
[40700] (04/05 13:29:15.525):{0x2E4} {user@domain.com} Receiving packet from device, size=41, TransactionId=-224996248, Tag=4847, content type=CMIME, cmd=0x3
[40698] (04/05 13:29:15.525):{0x2E4} {user@domain.com} Receiving OTAFM request from device, Tag=4847, TransactionId=-224996248
[30275] (04/05 13:29:15.525):{0x2E4} {user@domain.com} Received SEND_CHANGES_REQUEST from device, Tag=4847, TransactionId=-224996248
[40405] (04/05 13:29:15.541):{0x1290} {user@domain.com} MAPIMailbox::WeWantThisSentMessage - OpenEntry (0x8004010f) failed
[40423] (04/05 13:29:15.541):{0x1290} {user@domain.com} Queuing new mail through notification (external). EntryId=13064
[40405] (04/05 13:29:15.541):{0x1290} {user@domain.com} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40423] (04/05 13:29:15.541):{0x1290} {user@domain.com} Queuing new mail through notification (external). EntryId=13065
[40692] (04/05 13:29:15.619):{0x2E4} {user@domain.com} Starting message moved rescan
[40378] (04/05 13:29:15.635):{0x2E4} {user@domain.com} GetNewMovedMessages - Duplicate message detected, RefId=2032364841
[40383] (04/05 13:29:15.635):{0x2E4} {user@domain.com} HandleDuplicateRefId - Checking duplicate message, RefId=2032364841
[40379] (04/05 13:29:15.666):{0x2E4} {user@domain.com} HandleDuplicateRefId - Removing properties from message, RefId=2032364841
[40693] (04/05 13:29:15.713):{0x2E4} {user@domain.com} Message moved rescan completed
[40690] (04/05 13:29:15.713):{0x2E4} {user@domain.com} Starting message status rescan
[40691] (04/05 13:29:15.744):{0x2E4} {user@domain.com} Message status rescan completed
[40699] (04/05 13:29:15.744):{0x2E4} {user@domain.com} OTAFM request from device processed
[40279] (04/05 13:29:15.744):{0x2E4} {user@domain.com} SubmitToRelaySendQ, Tag=4847
[40724] (04/05 13:29:15.744):{0x2E4} {user@domain.com} Get record key for this MAPI object, EntryId=13064
[40000] (04/05 13:29:15.744):{0x1328} [BIPP] Send status DATA_ACCEPTED, Tag=4847
[40435] (04/05 13:29:15.744):{0x2E4} {user@domain.com} Queuing new mail through notification. EntryId=13064. Msgs Pending 0
[40724] (04/05 13:29:15.744):{0x2E4} {user@domain.com} Get record key for this MAPI object, EntryId=13065
[40435] (04/05 13:29:15.759):{0x2E4} {user@domain.com} Queuing new mail through notification. EntryId=13065. Msgs Pending 0
[40405] (04/05 13:29:15.759):{0x1290} {user@domain.com} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40726] (04/05 13:29:15.759):{0x1654} {user@domain.com} CheckForeignRIMProps - New message with RIM properties detected, deleting RIM properties. RefId=2032364841, EntryId=13064
[40405] (04/05 13:29:15.822):{0x1290} {user@domain.com} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[30233] (04/05 13:29:15.838):{0x1654} {user@domain.com} New message was found in SentItems, EntryId=13064
[40287] (04/05 13:29:15.900):{0x1654} {user@domain.com} Queuing message, RefId=-1136912023, EntryId=13064, Posted=05.04.2011 13:28:31, Delivered=05.04.2011 13:28:33
[30066] (04/05 13:29:15.900):{0x1654} Total Msgs Pending 2
[40405] (04/05 13:29:15.900):{0x1290} {user@domain.com} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40000] (04/05 13:29:15.900):{0x12F8} RpcGetSubject is called. [CH=90366328, MH=18447744]
[40000] (04/05 13:29:15.900):{0x12F8} RpcGetFirstAttachment is called. [CH=90366328, MH=18447744]
[30081] (04/05 13:29:15.900):{0x1E50} {user@domain.com} Sending message to device, size=168, EntryId=13064, RefId=-1136912023, TransactionId=-845561498, Tag=5060
[40279] (04/05 13:29:15.900):{0x1E50} {user@domain.com} SubmitToRelaySendQ, Tag=5060
[40000] (04/05 13:29:15.900):{0x1328} [BIPP] Send data, Tag=5060

Thanks.