Link to home
Start Free TrialLog in
Avatar of lorenetworks
lorenetworksFlag for United States of America

asked on

Exchange 2010 SP1 - Blackberry Enterprise Express - 5.02 MR1

Hey Everyone - have an issue and can not figure out what it is. I've googled every article out there and none seem to be/resolve the issue.
Setup -

Exchange 2010 SP1
Blackberry Enterprise Express 5.02 MR1 running on same server.


Symptoms -

Users can send email just fine from their blackberries.
Email deilivery to and from Outlook - works just fine.
Inbound emails to the blackberry are delayed in about 20 to 30 min Intervals.


Logs

Router -

[30000] (11/18 07:10:57.785):{0x3374} [SERVICE_RELAY_SESSION:S18851238:0x00A53548] Connection to relay established.
[30000] (11/18 07:10:57.785):{0x3374} [DIAG] EVENT=Unregister_thread, THREADID=0x3374, THREADNAME="Unnamed"
[30000] (11/18 07:10:57.926):{0x1904} [SERVICE_RELAY_SESSION:S18851238:0x00A53548] Service relay connection authenticated. SRPVersion: 3
[30000] (11/18 07:10:57.926):{0x1904} [SERVICE_MANAGER] Session authenticated. UID=S18851238, Session=0x00A53548
[30000] (11/18 07:10:57.926):{0x1904} [DEVICE_MANAGER] SRP StartListening. Port 4101.
[30000] (11/18 07:10:57.952):{0x230C} [DIAG] EVENT=Register_thread, THREADID=0x230C, THREADNAME="SRPListenerImp"
[30000] (11/18 07:21:01.776):{0x1904} [RELAY_SRP:S18851238:0x00A53230] Send: Pipe full
[10000] (11/18 07:51:58.162):{0x1904} [SERVICE_RELAY_SESSION:S18851238:0x00A53548] Service transaction not found. SERVICESESSION_TAG=3321014

(highlighted the ones i see being an issue).

MAGT -

logs of randoms for this --

[40700] (11/18 07:48:37.775):{0x838} {JWood} Receiving packet from device, size=162, TransactionId=-81625831, Tag=174489, content type=CMIME, cmd=0x3
[30112] (11/18 07:48:37.775):{0x838} {JWood} Receiving message from device, RefId=598162896, Tag=174489, TransactionId=-81625831, Date=11/18/2010 7:47:55 AM
[40291] (11/18 07:48:37.775):{0x838} {JWood} Refers to original message, RefId=-277635297
[40664] (11/18 07:48:39.701):{0x2528} {mohearn} Interactive request, Tag=174493
[40667] (11/18 07:48:39.701):{0x2528} {mohearn} Yield to interactive request (1), Tag=174493
[40700] (11/18 07:48:39.701):{0x2528} {mohearn} Receiving packet from device, size=63, TransactionId=-350419906, Tag=174493, content type=ALP, cmd=0x3
[30085] (11/18 07:48:39.703):{0x241C} {JShaut} New mail has arrived, EntryId=3786
[40583] (11/18 07:48:39.749):{0x2528} {mohearn} Sending packet to device, Size=247, Tag=114984, TransactionId=-857401418
[40279] (11/18 07:48:39.749):{0x2528} {mohearn} SubmitToRelaySendQ, Tag=114984
[40279] (11/18 07:48:39.749):{0x2528} {mohearn} SubmitToRelaySendQ, Tag=174493
[40000] (11/18 07:48:39.749):{0x2014} [BIPP] Send data, Tag=114984
[40668] (11/18 07:48:39.749):{0x2528} {mohearn} Continue after interactive request, Tag=174493
[40000] (11/18 07:48:39.749):{0x2014} [BIPP] Send status DATA_ACCEPTED, Tag=174493
[40262] (11/18 07:48:39.796):{0x1FBC} {HNowrouzi} StateDb - Found RefId=-1202478885
[40000] (11/18 07:48:44.594):{0x23C8} [BIPP] Received status DELIVERED, Tag=114984
[40891] (11/18 07:48:45.612):{0x190} {AAndreassi} No changes detected, rescan complete (type=Memos)
[40800] (11/18 07:48:45.612):{0x324} {AAndreassi} Starting Address Book rescan
[40405] (11/18 07:48:45.620):{0x1F4C} {masefi} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40405] (11/18 07:48:45.630):{0x1F4C} {masefi} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40423] (11/18 07:48:45.630):{0x1F4C} {masefi} Queuing new mail through notification (external). EntryId=3872
[40724] (11/18 07:48:45.630):{0x1F54} {masefi} Get record key for this MAPI object, EntryId=3872
[40423] (11/18 07:48:45.630):{0x1F4C} {masefi} Queuing new mail through notification (external). EntryId=3873
[40435] (11/18 07:48:45.634):{0x1F54} {masefi} Queuing new mail through notification. EntryId=3872. Msgs Pending 0
[40724] (11/18 07:48:45.634):{0x1F54} {masefi} Get record key for this MAPI object, EntryId=3873
[40405] (11/18 07:48:45.638):{0x1F4C} {masefi} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40974] (11/18 07:48:45.638):{0x1F4C} {masefi} Queuing notification of modified mail
[40229] (11/18 07:48:45.640):{0x1F4C} {masefi} Queuing notification of moved mail. EntryId=3874
[40405] (11/18 07:48:45.640):{0x1F54} {masefi} MAPIMailbox::OpenMessage - OpenEntry (0x8004010f) failed
[40725] (11/18 07:48:45.640):{0x1F54} {masefi} Unable to get record key for this MAPI object, EntryId=3873
[30078] (11/18 07:48:45.658):{0x1F54} {masefi} Message already transferred, EntryId=3872, RefId=0
[40267] (11/18 07:48:46.123):{0x3E4} {DOrtner} Starting calendar rescan
[40853] (11/18 07:48:46.403):{0x1F40} {KHemeng} Starting Tasks rescan
[40891] (11/18 07:48:46.567):{0x2868} {aunderwood} No changes detected, rescan complete (type=Tasks)
[40000] (11/18 07:48:49.936):{0x23C8} [BIPP] Received datagram, Tag=174494
[40262] (11/18 07:48:54.319):{0x838} {JWood} StateDb - Found RefId=-277635297
[40000] (11/18 07:48:55.977):{0x23C8} [BIPP] Received datagram, Tag=174495
[40000] (11/18 07:48:55.978):{0x218C} {ESeidel} Processed MULTI_STATS from Dispatcher, Tag=174495
[40000] (11/18 07:48:56.965):{0x23C8} [BIPP] Received datagram, Tag=174496
[40692] (11/18 07:48:58.510):{0x22B4} {NShaut} Starting message moved rescan
[40000] (11/18 07:48:59.182):{0x23C8} [BIPP] Received datagram, Tag=174497
[40800] (11/18 07:48:59.244):{0x2610} {aunderwood} Starting Address Book rescan
[40691] (11/18 07:49:01.764):{0x74C} {TDodd} Message status rescan completed
[30066] (11/18 07:49:02.441):{0xFAC} Total Msgs Pending 29
[40913] (11/18 07:49:02.442):{0x263C} {jfowler} Device 30AB4E0B state: in coverage
[40000] (11/18 07:49:02.442):{0x3234} {jfowler} Processed MULTI_STATS from Dispatcher, Tag=174496
[40692] (11/18 07:49:02.614):{0x128C} {MDoischen} Starting message moved rescan
[40719] (11/18 07:49:07.382):{0x22B4} {NShaut} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:49:07.382):{0x22B4} {NShaut} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-186666584
[40702] (11/18 07:49:07.800):{0x190} {wjackson} Starting message rescan due to rescan timer
[40229] (11/18 07:49:11.827):{0x1F4C} {mhunter} Queuing notification of moved mail. EntryId=3876
[40975] (11/18 07:49:11.895):{0x1F4C} {DCallen} Queuing notification of deleted mail
[30085] (11/18 07:49:11.944):{0x2D50} {MEthier} New mail has arrived, EntryId=3861
[40509] (11/18 07:49:11.944):{0x2D50} {MEthier} Message already has RefId=-849797529
[40287] (11/18 07:49:11.944):{0x2D50} {MEthier} Queuing message, RefId=-849797529, EntryId=3861, Posted=11/17/2010 4:44:22 PM, Delivered=11/17/2010 4:44:23 PM
[30066] (11/18 07:49:11.944):{0x2D50} Total Msgs Pending 30
[40856] (11/18 07:49:13.771):{0x2308} {cshaut} Starting Memos rescan
[40856] (11/18 07:49:14.263):{0x218C} {VTessierleon} Starting Memos rescan
[40693] (11/18 07:49:17.276):{0x22B4} {NShaut} Message moved rescan completed
[40702] (11/18 07:49:18.797):{0x7F4} {DCain} Starting message rescan due to rescan timer
[40287] (11/18 07:49:19.857):{0x241C} {JShaut} Queuing message, RefId=-499642702, EntryId=3786, Posted=11/18/2010 7:31:58 AM, Delivered=11/18/2010 7:33:01 AM
[30066] (11/18 07:49:19.857):{0x241C} Total Msgs Pending 31
[30097] (11/18 07:49:19.858):{0x21AC} {JShaut} Message has been delivered to device, Tag=114982, EntryId=3787
[40891] (11/18 07:49:19.871):{0x2F54} {SMclarty} No changes detected, rescan complete (type=Address Book)
[40891] (11/18 07:49:19.873):{0xE94} {tburke} No changes detected, rescan complete (type=Address Book)
[40691] (11/18 07:49:19.876):{0x194C} {Kmorrissey} Message status rescan completed
[40000] (11/18 07:49:19.877):{0x263C} {Kmorrissey} Processed MULTI_STATS from Dispatcher, Tag=174476
[40701] (11/18 07:49:25.264):{0x3E4} {DOrtner} Calendar rescan completed
[40891] (11/18 07:49:25.264):{0x324} {AAndreassi} No changes detected, rescan complete (type=Address Book)
[40702] (11/18 07:49:25.264):{0x2D50} {DOrtner} Starting message rescan due to rescan timer
[40891] (11/18 07:49:25.305):{0x1F40} {KHemeng} No changes detected, rescan complete (type=Tasks)
[30147] (11/18 07:49:25.312):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - FindRow (0x8004010f) failed
[40891] (11/18 07:49:31.086):{0x22B8} {JErazo} No changes detected, rescan complete (type=Address Book)
[40891] (11/18 07:49:31.088):{0x5F0} {F} No changes detected, rescan complete (type=Address Book)
[40267] (11/18 07:49:31.514):{0x74C} {ESeidel} Starting calendar rescan
[30066] (11/18 07:49:35.425):{0x2440} Total Msgs Pending 30
[30066] (11/18 07:49:37.468):{0x21AC} Total Msgs Pending 29
[40703] (11/18 07:49:37.512):{0x190} {wjackson} Message rescan completed
[40000] (11/18 07:49:40.408):{0x23C8} [BIPP] Ping 10 received
[40000] (11/18 07:49:40.408):{0x2014} [BIPP] Send Ping Response 10
[40183] (11/18 07:49:43.572):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - Could not find RefId=-600396910
[40175] (11/18 07:49:54.064):{0x7F4} {DCain} MAPIMailbox::GetNewMessages found 3 message(s) in Inbox
[30247] (11/18 07:49:58.660):{0x3328} Server stats - Msgs: Forwarded 152466, Sent 12308, Pending 29, Expired 0, Filtered 61, Forwarded/Min 1, Sent/Min 0
[40719] (11/18 07:50:02.600):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.600):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-666773708
[40719] (11/18 07:50:02.600):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.600):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-204830997
[40719] (11/18 07:50:02.600):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.600):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-640275807
[40719] (11/18 07:50:02.601):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.601):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1440078898
[40719] (11/18 07:50:02.601):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.601):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1140043715
[40719] (11/18 07:50:02.601):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.601):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-255876415
[40719] (11/18 07:50:02.601):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:02.601):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-440735664
[40891] (11/18 07:50:07.178):{0x2308} {cshaut} No changes detected, rescan complete (type=Memos)
[40891] (11/18 07:50:07.283):{0x2610} {aunderwood} No changes detected, rescan complete (type=Address Book)
[40699] (11/18 07:50:14.138):{0x1FBC} {HNowrouzi} OTAFM request from device processed
[40279] (11/18 07:50:14.138):{0x1FBC} {HNowrouzi} SubmitToRelaySendQ, Tag=174492
[40000] (11/18 07:50:14.138):{0x2014} [BIPP] Send status DATA_ACCEPTED, Tag=174492
[40700] (11/18 07:50:14.138):{0x241C} {HNowrouzi} Receiving packet from device, size=50, TransactionId=725607711, Tag=174497, content type=CMIME, cmd=0x3
[40698] (11/18 07:50:14.138):{0x241C} {HNowrouzi} Receiving OTAFM request from device, Tag=174497, TransactionId=725607711
[40572] (11/18 07:50:14.139):{0x241C} {HNowrouzi} Receiving MESSAGE_STATUS_UPDATE request from device, Tag=174497, TransactionId=725607711, RefId=-431673272, MsgStatus=1
[40266] (11/18 07:50:14.140):{0x7F4} {DCain} Queuing new mail through rescan. EntryId=3880
[40266] (11/18 07:50:14.140):{0x7F4} {DCain} Queuing new mail through rescan. EntryId=3879
[40266] (11/18 07:50:14.140):{0x7F4} {DCain} Queuing new mail through rescan. EntryId=3878
[40703] (11/18 07:50:14.140):{0x7F4} {DCain} Message rescan completed
[40267] (11/18 07:50:15.769):{0x263C} {kbigenho} Starting calendar rescan
[30147] (11/18 07:50:23.639):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - FindRow (0x8004010f) failed
[40692] (11/18 07:50:27.722):{0x22B8} {menglert} Starting message moved rescan
[40701] (11/18 07:50:35.446):{0x74C} {ESeidel} Calendar rescan completed
[40000] (11/18 07:50:35.962):{0x23C8} [BIPP] Received datagram, Tag=174498
[40000] (11/18 07:50:35.962):{0x23C8} [BIPP] Received datagram, Tag=174499
[40800] (11/18 07:50:37.893):{0x7F4} {amann} Starting Address Book rescan
[40442] (11/18 07:50:46.267):{0xFAC} User settings: email=tburke, routing=S18851238, service=&Design BES, device=309A32DE, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=tburke, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40856] (11/18 07:50:46.267):{0x1F40} {tburke} Starting Memos rescan
[40183] (11/18 07:50:46.331):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - Could not find RefId=-586724662
[30147] (11/18 07:50:46.339):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - FindRow (0x8004010f) failed
[40858] (11/18 07:50:46.432):{0x218C} {VTessierleon} RescanPIMItems - Memos rescan completed, no changes detected
[40442] (11/18 07:50:52.669):{0x2D40} User settings: email=jfowler, routing=S18851238, service=&Design BES, device=30AB4E0B, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=jfowler, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40702] (11/18 07:50:52.669):{0x2610} {jfowler} Starting message rescan due to rescan timer
[40701] (11/18 07:50:52.674):{0x263C} {kbigenho} Calendar rescan completed
[40690] (11/18 07:50:52.674):{0x74C} {SMclarty} Starting message status rescan
[40692] (11/18 07:50:52.674):{0x1FBC} {kbigenho} Starting message moved rescan
[40693] (11/18 07:50:52.695):{0x2298} {RGettys} Message moved rescan completed
[40000] (11/18 07:50:53.237):{0x23C8} [BIPP] Received datagram, Tag=174500
[40719] (11/18 07:50:56.467):{0x22B8} {menglert} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:50:56.467):{0x22B8} {menglert} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1990278774
[40891] (11/18 07:51:04.383):{0x7F4} {amann} No changes detected, rescan complete (type=Address Book)
[40442] (11/18 07:51:12.473):{0xE94} User settings: email=Jcrenca, routing=S18851238, service=&Design BES, device=3143D05A, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=Jcrenca, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40442] (11/18 07:51:12.770):{0x3234} User settings: email=Kmorrissey, routing=S18851238, service=&Design BES, device=30AB48CB, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=Kmorrissey, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40800] (11/18 07:51:12.770):{0x2D40} {Kmorrissey} Starting Address Book rescan
[40702] (11/18 07:51:12.826):{0x21AC} {JErazo} Starting message rescan due to rescan timer
[40000] (11/18 07:51:15.561):{0x23C8} [BIPP] Ping 11 received
[40000] (11/18 07:51:15.561):{0x2014} [BIPP] Send Ping Response 11
[40442] (11/18 07:51:20.404):{0x2394} User settings: email=Mfassbach, routing=S18851238, service=&Design BES, device=32CD0B6D, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=Mfassbach, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40000] (11/18 07:51:20.404):{0x263C} {Mfassbach} Processed MULTI_STATS from Dispatcher, Tag=174494
[40692] (11/18 07:51:20.404):{0x25F8} {Mfassbach} Starting message moved rescan
[40183] (11/18 07:51:20.454):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - Could not find RefId=-573450697
[40442] (11/18 07:51:20.456):{0x2440} User settings: email=Hstanwood, routing=S18851238, service=&Design BES, device=32CC960E, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=Hstanwood, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40800] (11/18 07:51:20.457):{0x670} {Hstanwood} Starting Address Book rescan
[40933] (11/18 07:51:21.102):{0x1834} Completed check for changes in public folders.  Elapsed time 0 milliseconds
[30085] (11/18 07:51:28.708):{0xDA8} {Jdivel} New mail has arrived, EntryId=3868
[40702] (11/18 07:51:29.871):{0xE94} {amann} Starting message rescan due to rescan timer
[40000] (11/18 07:51:31.957):{0x23C8} [BIPP] Received datagram, Tag=174501
[40182] (11/18 07:51:32.065):{0x241C} {HNowrouzi} MAPIMailbox::RefIDtoEntryID - Found RefId=-431673272
[40570] (11/18 07:51:35.645):{0x2120} {STodd} FindAndQueueNewMessageStatusUpdates - New Status Update detected, queuing OTAFM MESSAGE_STATUS_UPDATE command for RefId=-954994500
[40442] (11/18 07:51:35.646):{0x1D4C} User settings: email=sowen, routing=S18851238, service=&Design BES, device=32CD0F16, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=sowen, server=EXCHANGESERVER (session : 0x037910a8), pending=22
[40267] (11/18 07:51:35.646):{0xFAC} {sowen} Starting calendar rescan
[40570] (11/18 07:51:35.681):{0x2120} {STodd} FindAndQueueNewMessageStatusUpdates - New Status Update detected, queuing OTAFM MESSAGE_STATUS_UPDATE command for RefId=-1489661677
[40570] (11/18 07:51:35.691):{0x2120} {STodd} FindAndQueueNewMessageStatusUpdates - New Status Update detected, queuing OTAFM MESSAGE_STATUS_UPDATE command for RefId=-946179561
[40691] (11/18 07:51:35.691):{0x2120} {STodd} Message status rescan completed
[40267] (11/18 07:51:40.805):{0x3234} {DVogt} Starting calendar rescan
[40719] (11/18 07:51:41.988):{0x25F8} {Mfassbach} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:51:41.988):{0x25F8} {Mfassbach} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-143964603
[30147] (11/18 07:51:41.996):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - FindRow (0x8004010f) failed
[40692] (11/18 07:51:42.520):{0x22B4} {masefi} Starting message moved rescan
[40719] (11/18 07:51:42.769):{0x22B4} {masefi} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:51:42.769):{0x22B4} {masefi} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1092903728
[40719] (11/18 07:51:42.770):{0x22B4} {masefi} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:51:42.770):{0x22B4} {masefi} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-184066084
[40693] (11/18 07:51:42.773):{0x22B4} {masefi} Message moved rescan completed
[30181] (11/18 07:51:43.983):{0x201C} Performing system health check (BlackBerry Mailbox Agent 1 - BESX Version 5.0.2.15)
[30509] (11/18 07:51:43.983):{0x201C} Current health score, Health=0x000000000200150F, Mask=0x000000000200150F
[30399] (11/18 07:51:43.983):{0x201C} Worker Thread:  *** Busy Working ***  Thread Id=0x3244, Handle=0xd64, BusyCount=1, WorkingTime=14 min, LastActivity=0 min, Event: SEND_FLDR_LIST, User: SImhof, Server: EXCHANGESERVER, Activity: Starting message status rescan
[30399] (11/18 07:51:43.984):{0x201C} Worker Thread:  *** Busy Working ***  Thread Id=0x2364, Handle=0xe04, BusyCount=1, WorkingTime=11 min, LastActivity=3 min, Event: NEW_MESSAGE, User: LSanders, Server: EXCHANGESERVER, Activity: Send - SubmitMessage
[30399] (11/18 07:51:43.984):{0x201C} Worker Thread:  *** Busy Working ***  Thread Id=0x2104, Handle=0xe34, BusyCount=1, WorkingTime=16 min, LastActivity=0 min, Event: SEND_FLDR_LIST, User: B, Server: EXCHANGESERVER, Activity: Starting message status rescan
[40360] (11/18 07:51:43.985):{0x201C} [BIPPa] Health: QSize=0, intMap=5
[40800] (11/18 07:51:45.204):{0x2308} {VTessierleon} Starting Address Book rescan
[40287] (11/18 07:51:45.821):{0xDA8} {Jdivel} Queuing message, RefId=-1687924744, EntryId=3868, Posted=11/18/2010 7:31:58 AM, Delivered=11/18/2010 7:33:13 AM
[30066] (11/18 07:51:45.821):{0xDA8} Total Msgs Pending 30
[40891] (11/18 07:51:45.826):{0x1F40} {tburke} No changes detected, rescan complete (type=Memos)
[40853] (11/18 07:51:45.826):{0x1D4C} {tburke} Starting Tasks rescan
[40175] (11/18 07:51:47.270):{0x21AC} {JErazo} MAPIMailbox::GetNewMessages found 2 message(s) in Inbox
[40800] (11/18 07:51:51.737):{0x263C} {lcortright} Starting Address Book rescan
[40693] (11/18 07:51:54.363):{0x22B8} {menglert} Message moved rescan completed
[40292] (11/18 07:51:58.160):{0x2364} {LSanders} Email message sent for device, Tag=174467
[40279] (11/18 07:51:58.160):{0x2364} {LSanders} SubmitToRelaySendQ, Tag=174467
[40000] (11/18 07:51:58.161):{0x2014} [BIPP] Send status DATA_ACCEPTED, Tag=174467
[40000] (11/18 07:51:58.161):{0x32FC} {LSanders} Processed MULTI_STATS from Dispatcher, Tag=174471
[40000] (11/18 07:51:58.161):{0x324} {LSanders} Processed MULTI_STATS from Dispatcher, Tag=174475
[40700] (11/18 07:51:58.162):{0x2440} {LSanders} Receiving packet from device, size=166, TransactionId=-1784422399, Tag=174483, content type=CMIME, cmd=0x3
[30113] (11/18 07:51:58.162):{0x2440} {LSanders} Duplicate message from device, RefId=547568412, Tag=174483
[40279] (11/18 07:51:58.162):{0x2440} {LSanders} SubmitToRelaySendQ, Tag=174483
[40000] (11/18 07:51:58.162):{0x2014} [BIPP] Send status DATA_ACCEPTED, Tag=174483
[40891] (11/18 07:51:58.391):{0x2D40} {Kmorrissey} No changes detected, rescan complete (type=Address Book)
[40701] (11/18 07:52:04.707):{0xFAC} {sowen} Calendar rescan completed
[40690] (11/18 07:52:04.708):{0x218C} {sowen} Starting message status rescan
[40000] (11/18 07:52:04.970):{0x23C8} [BIPP] Received datagram, Tag=174502
[40975] (11/18 07:52:08.953):{0x1F4C} {DCallen} Queuing notification of deleted mail
[40000] (11/18 07:52:08.956):{0x1F40} {RGettys} Processed MULTI_STATS from Dispatcher, Tag=174502
[40000] (11/18 07:52:12.120):{0x23C8} [BIPP] Received datagram, Tag=174503
[40677] (11/18 07:52:12.790):{0x21AC} {JErazo} MAPIMailbox::GetNewMessages found 2 message(s) in SentItems
[40266] (11/18 07:52:12.791):{0x21AC} {JErazo} Queuing new mail through rescan. EntryId=3883
[40266] (11/18 07:52:12.791):{0x21AC} {JErazo} Queuing new mail through rescan. EntryId=3885
[40266] (11/18 07:52:12.791):{0x21AC} {JErazo} Queuing new mail through rescan. EntryId=3882
[40266] (11/18 07:52:12.791):{0x21AC} {JErazo} Queuing new mail through rescan. EntryId=3884
[40703] (11/18 07:52:12.791):{0x21AC} {JErazo} Message rescan completed
[40701] (11/18 07:52:12.794):{0x3234} {DVogt} Calendar rescan completed
[40000] (11/18 07:52:26.029):{0x23C8} [BIPP] Received datagram, Tag=174504
[40175] (11/18 07:52:26.588):{0xE94} {amann} MAPIMailbox::GetNewMessages found 4 message(s) in Inbox
[40891] (11/18 07:52:26.608):{0x1D4C} {tburke} No changes detected, rescan complete (type=Tasks)
[40000] (11/18 07:52:29.033):{0x23C8} [BIPP] Received datagram, Tag=174505
[40000] (11/18 07:52:29.033):{0x1F54} {masefi} Processed MULTI_STATS from Dispatcher, Tag=174505
[40000] (11/18 07:52:30.038):{0x23C8} [BIPP] Received datagram, Tag=174506
[40183] (11/18 07:52:30.812):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - Could not find RefId=-134227337
[40442] (11/18 07:52:30.831):{0x194C} User settings: email=F, routing=S18851238, service=&Design BES, device=22723B5F, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=F, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40267] (11/18 07:52:30.831):{0x21AC} {F} Starting calendar rescan
[40692] (11/18 07:52:32.852):{0x3234} {mhunter} Starting message moved rescan
[40442] (11/18 07:52:33.604):{0x7F4} User settings: email=ESeidel, routing=S18851238, service=&Design BES, device=30AB4B2C, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=ESeidel, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40853] (11/18 07:52:34.406):{0x2120} {GWeissgerber} Starting Tasks rescan
[40690] (11/18 07:52:34.658):{0x22B4} {masefi} Starting message status rescan
[40691] (11/18 07:52:34.840):{0x22B4} {masefi} Message status rescan completed
[40891] (11/18 07:52:41.399):{0x670} {Hstanwood} No changes detected, rescan complete (type=Address Book)
[30147] (11/18 07:52:41.403):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - FindRow (0x8004010f) failed
[40701] (11/18 07:52:43.668):{0x21AC} {F} Calendar rescan completed
[40719] (11/18 07:52:47.835):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.835):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1148332163
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-2024595982
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-137743111
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-599277401
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-558555851
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-2024601821
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1343164144
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1684893923
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.836):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1777200781
[40719] (11/18 07:52:47.836):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-680382243
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-726535672
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1551865515
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1736479231
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1828786089
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-187107706
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1438682168
[40719] (11/18 07:52:47.837):{0x3234} {mhunter} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:47.837):{0x3234} {mhunter} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1987091437
[40000] (11/18 07:52:47.948):{0x23C8} [BIPP] Received datagram, Tag=174507
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=1417899202
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1696997228
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-414486071
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1458403704
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1040865037
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-861919894
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.250):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-563677989
[40719] (11/18 07:52:58.250):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1607595622
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-205787703
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1190056955
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1458545635
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-235682859
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1905979458
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1369144029
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-295473171
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1607879484
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-385016708
[40719] (11/18 07:52:58.251):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.251):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-86774803
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-27126422
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1011395674
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-951747293
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-115705984
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1159623617
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-56057603
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1099975236
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1428112297
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1338710691
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-235144677
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1696742908
[40719] (11/18 07:52:58.252):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.252):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-235286608
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-931027778
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-921455886
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1726779995
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-444268838
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1816323532
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-474163994
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-2144460593
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=563422347
[40719] (11/18 07:52:58.253):{0x128C} {MDoischen} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:52:58.253):{0x128C} {MDoischen} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1522594442
[40703] (11/18 07:52:58.259):{0x2610} {jfowler} Message rescan completed
[40800] (11/18 07:52:58.260):{0x7F4} {jfowler} Starting Address Book rescan
[40891] (11/18 07:52:58.263):{0x2120} {GWeissgerber} No changes detected, rescan complete (type=Tasks)
[40000] (11/18 07:53:00.728):{0x23C8} [BIPP] Ping 12 received
[40000] (11/18 07:53:00.728):{0x2014} [BIPP] Send Ping Response 12
[40703] (11/18 07:53:03.269):{0x2D50} {DOrtner} Message rescan completed
[40000] (11/18 07:53:03.270):{0x1DBC} {DOrtner} Processed MULTI_STATS from Dispatcher, Tag=174498
[40891] (11/18 07:53:03.271):{0x263C} {lcortright} No changes detected, rescan complete (type=Address Book)
[40719] (11/18 07:53:07.352):{0x25F8} {Mfassbach} GetFolderIDFromList No folder ID in list for EntryID
[40599] (11/18 07:53:07.352):{0x25F8} {Mfassbach} GetNewMovedMessages - Could not find folder entry id in folder list for RefId=-1092074621
[40442] (11/18 07:53:07.353):{0x314C} User settings: email=STodd, routing=S18851238, service=&Design BES, device=2436B319, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=STodd, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[40442] (11/18 07:53:07.353):{0xDA8} User settings: email=aunderwood, routing=S18851238, service=&Design BES, device=320A11CD, calendar=1, MDS=1, userOTAFM=63, incradle=0, SMIME=0, sentItems=1, dir=A, server=EXCHANGESERVER (session : 0x037910a8), pending=0
[30262] (11/18 07:53:07.353):{0x670} {STodd} Preparing OTAFM Batch
[40560] (11/18 07:53:07.353):{0x670} {STodd} Batching OTAFM MESSAGE_STATUS_UPDATE command for RefId=-1489661677, status=1, TransactionID=-857401421
[40560] (11/18 07:53:07.353):{0x670} {STodd} Batching OTAFM MESSAGE_STATUS_UPDATE command for RefId=-954994500, status=1, TransactionID=-857401421
[40702] (11/18 07:53:07.353):{0x21AC} {aunderwood} Starting message rescan due to rescan timer
[40560] (11/18 07:53:07.353):{0x670} {STodd} Batching OTAFM MESSAGE_STATUS_UPDATE command for RefId=-946179561, status=1, TransactionID=-857401421
[30289] (11/18 07:53:07.353):{0x670} {STodd} 3 OTAFM commands sent in batch for TransactionId=-857401421, Tag=114985, size=70
[40279] (11/18 07:53:07.353):{0x670} {STodd} SubmitToRelaySendQ, Tag=114985
[30066] (11/18 07:53:07.354):{0x670} Total Msgs Pending 31
[40000] (11/18 07:53:07.354):{0x2014} [BIPP] Send data, Tag=114985
[40702] (11/18 07:53:07.354):{0x32FC} {STodd} Starting message rescan due to rescan timer
[40183] (11/18 07:53:07.354):{0x2510} {Ckhiel} MAPIMailbox::RefIDtoEntryID - Could not find RefId=252941052
[40693] (11/18 07:53:09.250):{0x3234} {mhunter} Message moved rescan completed

Windows App Logs -

1. [BIPPe] WARNING: Using default BIPP shared secret  (Blackberry Synchronization Error
2. [BIPPe] WARNING: Using default BIPP shared secret (Blackberry Policy Service)
2. [SERVICE_RELAY_SESSION:S18851238:0x00A53548] Service transaction not found. SERVICESESSION_TAG=3321014 (Blackberry Router)
3. BIPPeClient::Connect: Error calling host "localhost" [127.0.0.1] (10061) (Blackberry Policy Service)

Processes already tried for fixing solution -

1. Reboot (obviously)
2. Stop BES services for 20 mins
3. Delete MAPI profiles from registry and readd.

Not sure how or why this started happening. Was very random...

Thanks for the help




Avatar of Auric1983
Auric1983
Flag of Canada image
Did you follow the KB Article from Blackberry? Specifically the piece about creating a new throttling policy for the BES

http://www.blackberry.com/btsc/search.do?cmd=displayKC&docType=kc&externalId=KB22601

Avatar of lorenetworks
lorenetworks
Flag of United States of America image

ASKER

Yes - this was applied and all features double checked in article.

BB Support is now giving me the finger because i'm using a Citrix Xen Environment which makes no sense considering i have 7 other exchange servers in different environments running on Xen working just fine in the exact damn configuration.

Thanks BB Support! your the best!

ASKER CERTIFIED SOLUTION
Avatar of lorenetworks
lorenetworks
Flag of United States of America image
Link to home
membership
This solution is only available to members.
To access this solution, you must be a member of Experts Exchange.
Start Free Trial
Avatar of Auric1983
Auric1983
Flag of Canada image
haha Thanks Lorenetworks -

BES 5.0.2 uses a LOT of memory, I ran into an issue with that myself on a machine here, it only had 1gb of ram!! egads it was bad
Avatar of lorenetworks
lorenetworks
Flag of United States of America image

ASKER

I figured out the issue and i believe this will help others do the same.
Avatar of jmgallo
jmgallo
I'm surprised you're working fine with 2010 SP1 and BESx 5.02, as everything I can find says that SP1 isn't supported yet.  Just RU4 (I think).

Was at a RIM event a couple weeks ago and they said they're trying to get BES 5.03 out the door, and hope (but can't promise anything) that BESx will come out the same time or hopefully shortly after.