Welcome!

Welcome to the official BlackBerry Support Community Forums.

This is your resource to discuss support topics with your peers, and learn from each other.

Reply
New Contributor
ichibanto
Posts: 4
Registered: ‎09-22-2012
My Device: 9360
Accepted Solution

Email delivery issues

Hi,

 

I have some BES express issues.  I'm running Exchange 2010 14.02.0309.002, BES Express 5.0.3 (bundle 12). Both are installed on seperate 2008 R2.

 

Some devices have had no email delivery for 4-5 days. Some receive a glut of emails sporadically, after a period of delay. The devices cannot lookup the Exchange GAL that are not receiving email messages to their devices.

 

In the even log are errors such as:

 

RIM_HrResolveProxysFromDN - ResolveNamesMAPI failed from -2147221233

 

----------------------------------------------------------------------------------------------------------------

 

{Firstname Surname} MAPIMailbox::~MAPIMailbox - Exception handled

 

-----------------------------------------------------------------------------------------------------------------

 

Faulting application name: BAS-NCC.exe, version: 1.2.3.0, time stamp: 0x4c6c52b7

Faulting module name: BASWinDS.dll, version: 5.0.3.41, time stamp: 0x4daf4198

Exception code: 0xc000000d

Fault offset: 0x0007c5bc

Faulting process id: 0x1150

Faulting application start time: 0x01cd99070d0b3e2a

Faulting application path: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BAS\External\Bin\BAS-NCC.exe

Faulting module path: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BAS\dll\BASWinDS.dll

Report Id: 47113d1b-0502-11e2-8e6a-005056844d23

 

Re-occuring failure of above.

 

And also:

 

Fault bucket , type 0

Event Name: BEX

Response: Not available

Cab Id: 0

Problem signature:

P1: BAS-NCC.exe

P2: 1.2.3.0

P3: 4c6c52b7

P4: BASWinDS.dll

P5: 5.0.3.41

P6: 4daf4198

P7: 0007c5bc

P8: c000000d

P9: 00000000

P10:

Attached files:

These files may be available here:

C:\ProgramData\Microsoft\Windows\WER\ReportQueue\AppCrash_BAS-NCC.exe_e7616e4befe65219cf23d47af614e1dfc5a6_206dd5ed

Analysis symbol:

Rechecking for solution: 0

Report Id: 47113d1b-0502-11e2-8e6a-005056844d23

Report Status: 4

 

 

The server has been rebooted but to no avail.  Thanks in advance.

New Contributor
ichibanto
Posts: 4
Registered: ‎09-22-2012
My Device: 9360

Re: Logs plus MAGT

See attached logs including the MAGT log for further information.  Thanks.

 

C:\Program Files\ExchangeMAPI\
CDO version 1.2.1 (6.5.8165)

BES server C:\Windows\System32\mapi32.dll    CAS, HUB
File version 1.0.2536  
Product version  6.1.7601.17514

 

CALH LOG

[30000] (09/23 00:31:08.711):{0x2070} {fname.surname@mydomain} Service::TestAccessToMailbox Soap Exception caught: The account does not have permission to impersonate the requested user.
[30000] (09/23 00:31:08.711):{0x2070} {fname.surname@mydomain} Diagnosis: The BES service account does not have impersonation rights for this user.
[30000] (09/23 00:31:08.711):{0x2070} {fname.surname@mydomain} Please consult the BES installation guide for Exchange Server configuration information.

 

 

CMNG LOG

[30017] (09/23 00:05:46.981):{0x14D0} {fname surname.398} Performing DeviceUserState check for records with no response.
[40089] (09/23 00:05:46.981):{0x14D0} {fname surname.398} CheckResponseReceived - no changes detected.

 


DISP LOG Output
[30222] (09/23 00:07:33.419):{0x99C} {fname surname} MTH: contentType=CICAL, sizeOTA=74, sizeOTW=18, TransactionId=-799243693, Tag=19517629
[30310] (09/23 00:07:33.419):{0x99C} {fname surname} Forwarding internal data to device, contentType=CICAL, routing=S80634750, device=, size=103, cmd=0x3, ack=0, TransactionId=-799243693, intTag=14452378, Tag=19517629, Submit=1
[30375] (09/23 00:07:33.450):{0x998} {fname surname} Packet returned as FAILED - could not be delivered to device, Tag=19517629

 


BBAS LOG EXTRACT
(09/23 02:10:05:292):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182421} Enter bean JobManagerBean.setIncompleteTaskAsFailedInNewTransactionLocal
(09/23 02:10:05:307):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182421} setIncompleteTaskAsFailedInNewTransactionLocal call delivery manager to cancel the task, taskId = 43550
(09/23 02:10:05:307):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182421} _updateJobThrottlingAvailableSystemSlotsCount update the Job Throttling System Data with following: objectTypePlugInId = 0, objectTypeId = 1, availableSystemSlotsChanges = 1
(09/23 02:10:05:307):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182421} _updateJobThrottlingAvailableSystemSlotsCount system slots available number after update is 1000
(09/23 02:10:05:307):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182433} Enter bean JobManagerBean.updateDependentTaskStateAsDependencyFailureInNewTransactionLocal
(09/23 02:10:05:572):{WorkManager(2)-7067} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=182433} Exit bean JobManagerBean.updateDependentTaskStateAsDependencyFailureInNewTransactionLocal
..
(09/23 10:19:44:146):{WorkManager(2)-8430} [com.rim.bes.bas.jobmanager.JobManagerBean] [DEBUG] [BBAS-200] {u=SystemUser, t=203658} _updateJobState update the job(25038) state to COMPLETED_WITH_NO_TASK_FAILURE

 


POLC LOG
[40000] (09/23 00:23:04.322):{0x163C} [BIPP] Ping 2222 sent
[40000] (09/23 00:23:04.322):{0x1638} [BIPP] Ping Response 2222 received
[40000] (09/23 00:24:02.338):{0x1668} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
[40000] (09/23 00:24:04.334):{0x163C} [BIPP] Ping 2223 sent
[40000] (09/23 00:24:04.334):{0x1638} [BIPP] Ping Response 2223 received
[40000] (09/23 00:24:33.256):{0x1648} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[20000] (09/23 00:24:33.506):{0x1648} POLC_UpdateBESUIDsInPolicy - Error parsing the Policy
[20000] (09/23 00:24:33.506):{0x1648} POLC_AddBESVersionToPolicy - Error parsing the Policy
[20000] (09/23 00:24:33.506):{0x1648} POLC_AddContentProtectionKeyToPolicy - Failed to parse the Policy.
[20000] (09/23 00:24:33.506):{0x1648} POLC_AddBESTypeFlagToPolicy - Error parsing the Policy
[20000] (09/23 00:24:33.506):{0x1648} POLC_AddWeakPolicyFlagToPolicy - Error parsing the Policy
[20000] (09/23 00:24:33.506):{0x1648} AddDigitalSignatureToPolicy - Error parsing the Policy
[40000] (09/23 00:24:33.506):{0x1648} {name@mydomain, PIN=0, UserId=285}SCS::CheckDBforInactiveUsers - Updating Policy State entry for new user
[40000] (09/23 00:24:33.553):{0x1648} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/23 00:25:02.303):{0x1668} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
..
MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
[40000] (09/23 03:29:11.403):{0x163C} [BIPP] Ping 2406 sent
[40000] (09/23 03:29:11.403):{0x1638} [BIPP] Ping Response 2406 received
[30181] (09/23 03:29:32.791):{0x1640} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - thebesserver [POLC] - Exchange)
[40000] (09/23 03:29:32.993):{0x1644} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[20000] (09/23 03:29:33.087):{0x1644} POLC_UpdateBESUIDsInPolicy - Error parsing the Policy
[20000] (09/23 03:29:33.087):{0x1644} POLC_AddBESVersionToPolicy - Error parsing the Policy
[20000] (09/23 03:29:33.087):{0x1644} POLC_AddContentProtectionKeyToPolicy - Failed to parse the Policy.
[20000] (09/23 03:29:33.087):{0x1644} POLC_AddBESTypeFlagToPolicy - Error parsing the Policy
[20000] (09/23 03:29:33.087):{0x1644} POLC_AddWeakPolicyFlagToPolicy - Error parsing the Policy
[20000] (09/23 03:29:33.087):{0x1644} AddDigitalSignatureToPolicy - Error parsing the Policy
[40000] (09/23 03:29:33.290):{0x1644} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/23 03:30:04.396):{0x1668} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
[40000] (09/23 03:30:11.416):{0x163C} [BIPP] Ping 2407 sent

 

 

SYNC LOG

Schofield:133]
[40000] (09/23 07:59:21.796):{0x155C} [BIPP] Received status FAILED, Tag=5159183
[40000] (09/23 07:59:21.796):{0x155C} [BIPP] Received status FAILED, Tag=5159184
[46066] (09/23 07:59:21.796):{0x133C} [SYNC-SSession] Received FAILED status from relay. [a name:75, SID=0, CLID=9, ECLID=83]
[46066] (09/23 07:59:21.796):{0x30C} [SYNC-SSession] Received FAILED status from relay. [firstname surname:72, SID=0, CLID=43, ECLID=2917]
[46051] (09/23 07:59:21.796):{0x30C} [SYNC-UserControl] BackoffServerSession is called, ServerSessionTimeout is changed to 80 minutes. [firstname surname:72]
[46051] (09/23 07:59:21.796):{0x133C} [SYNC-UserControl] BackoffServerSession is called, ServerSessionTimeout is changed to 80 minutes. firstname surname:75]
[40000] (09/23 07:59:21.827):{0x155C} [BIPP] Received status FAILED, Tag=5159185
[46066] (09/23 07:59:21.827):{0x12D0} [SYNC-SSession] Received FAILED status from relay. [firstname surname:95, SID=0, CLID=648, ECLID=117]
[46051] (09/23 07:59:21.827):{0x12D0} [SYNC-UserControl] BackoffServerSession is called, ServerSessionTimeout is changed to 80 minutes. [firstname surname:95]
[46008] (09/23 07:59:21.843):{0xF00} [SYNC-SSession] Send 1 packet(s) with 103 bytes to the device. [firstname surname:179, SID=164515487, CLID=38, ECLID=1574, TAG=5159192, ST=80]
[46052] (09/23 07:59:21.843):{0xF00} [SYNC-SSession] Contain 0 record(s) and 2 command(s) from Config. [firstname surname:179]
[40000] (09/23 07:59:21.843):{0x1560} [BIPP] Send data, Tag=5159192
[40000] (09/23 07:59:21.859):{0x155C} [BIPP] Received status FAILED, Tag=5159187
[40000] (09/23 07:59:21.859):{0x155C} [BIPP] Received status FAILED, Tag=5159189
[46066] (09/23 07:59:21.859):{0x13D4} [SYNC-SSession] Received FAILED status from relay. [firstname surname:107, SID=0, CLID=255, ECLID=7660]
[46066] (09/23 07:59:21.859):{0x1340} [SYNC-SSession] Received FAILED status from relay. [firstname surname:113, SID=0, CLID=233, ECLID=13030]
[46051] (09/23 07:59:21.859):{0x13D4} [SYNC-UserControl] BackoffServerSession is called, ServerSessionTimeout is changed to 80 minutes

 

 

 

MAGT Log entry
MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed

30089
 {%s} Configuration incomplete: Message ignored EntryId=%d

The specified user account configuration is incomplete, so messages are not processed. A BlackBerry device might not be assigned to this user account.

[40720] (09/23 00:02:09.348):{0x2B0C} MAPI call failed. Error 'Network problems are preventing connection to the Microsoft Exchange Server computer.', LowLevelError 6, Component 'Microsoft Exchange Server Information Store', Context 1300

 

[40583] (09/23 00:00:39.696):{0x2554} {fname.surname@mydomain.co.uk} Sending packet to device, Size=54, Tag=14452247, TransactionId=-799243662
[40279] (09/23 00:00:39.696):{0x2554} {fname.surname@mydomain.co.uk} SubmitToRelaySendQ, Tag=14452247
[40000] (09/23 00:00:39.696):{0x1B78} [BIPP] Send data, Tag=14452247
[40000] (09/23 00:00:39.727):{0x1BDC} [BIPP] Received status FAILED, Tag=14452247

Delivered=23/09/2012 00:00:32
[30066] (09/23 00:00:52.036):{0x2BB8} Total Msgs Pending 11349
[40405] (09/23 00:00:52.067):{0x1BE4} {fname.surnae@mydomain} MAPIMailbox::HandleObjectModifiedNotification - OpenEntry (0x8004010f) failed
[40000] (09/23 00:00:52.161):{0xF68} RpcGetSubject is called. [CH=148254416, MH=477027440]
[40000] (09/23 00:00:52.161):{0xF68} RpcGetFirstAttachment is called. [CH=148254416, MH=477027440]
[30081] (09/23 00:00:52.161):{0x26A8} {fname.surnae@mydomain} Sending message to device, size=428, EntryId=3344566, RefId=-1812531975, TransactionId=-799243799, Tag=14452249
[40279] (09/23 00:00:52.161):{0x26A8} {fname.surnae@mydomain} SubmitToRelaySendQ, Tag=14452249
[40000] (09/23 00:00:52.161):{0x1B78} [BIPP] Send data, Tag=14452249

[20709] (09/23 00:01:35.637):{0x2390} {fname.surname@mydomain.co.uk} Failed to reach user's mailbox


[20265] (09/23 00:01:37.525):{0x25E8} {fname.surname@mydomain.co.uk} MAPIMailbox::RescanPIMItems - GetProps (0x80040115) failed
[20265] (09/23 00:01:37.525):{0x25E8} {fname.surname@mydomain.co.uk} MAPIMailbox::RescanPIMItems - GetProps (0x80040115) failed
[20535] (09/23 00:01:37.525):{0x25E8} {fname.surname@mydomain.co.uk} RescanPIMItems - Failed getting contents table (type=Address Book) (0x80040115)
[20539] (09/23 00:01:37.525):{0x25E8} {fname.surname@mydomain.co.uk} RescanPIMItems(1) failed: ERR_NETWORK_PROBLEM
[40690] (09/23 00:01:37.743):{0x1430} {fname.surname@mydomain.co.uk} Starting message status rescan
[40267] (09/23 00:01:38.149):{0x25E0} {fname.surname@mydomain.co.uk} Starting calendar rescan
[40856] (09/23 00:01:38.960):{0x26AC} {fname.surname@mydomain.co.uk} Starting Memos rescan
[20265] (09/23 00:01:39.069):{0x26AC} {fname.surname@mydomain.co.uk} MAPIMailbox::RescanPIMItems - GetProps (0x80040115) failed
[20535] (09/23 00:01:39.069):{0x26AC} {fname.surname@mydomain.co.uk} RescanPIMItems - Failed getting contents table (type=Memos) (0x80040115)
[20539] (09/23 00:01:39.069):{0x26AC} {fname.surname@mydomain.co.uk} RescanPIMItems(3) failed: ERR_NETWORK_PROBLEM

[20265] (09/23 00:01:43.484):{0x1430} {@mydomain.co.uk} MAPIMailbox::GetMessageStatusUpdates - GetContentsTable (0x80004005) failed
[20274] (09/23 00:01:43.484):{0x1430} {@mydomain.co.uk} GetMessageStatusUpdates() failed
[20709] (09/23 00:01:43.484):{0x2318} {mydomain.co.uk} Failed to reach user's mailbox
[20709] (09/23 00:01:43.484):{0x2B0C} {@mydomain.co.uk} Failed to reach user's mailbox
[20265] (09/23 00:01:43.499):{0x1A60} {mydomain.co.uk} MAPIMailbox::GetNewMovedMessages - GetContentsTable (0x80004005) failed
[20275] (09/23 00:01:43.499):{0x1A60} {@mydomain.co.uk} GetNewMovedMessages() failed
[20709] (09/23 00:01:43.499):{0x2514} {@mydomain.co.uk} Failed to reach user's mailbox
[40720] (09/23 00:01:43.499):{0x26EC} MAPI call failed. Error 'The client operation failed.', LowLevelError 1005, Component 'Microsoft Exchange Server Information Store', Context 1281
[20171] (09/23 00:01:43.499):{0x26EC} {@mydomain.co.uk} ReloadPagerConfig() failed
[20709] (09/23 00:01:43.515):{0x1BD8} {@mydomain.co.uk} Failed to reach user's mailbox
[20265] (09/23 00:01:43.531):{0x25F8} {@mydomain.co.uk} MAPIMailbox::CheckLastChangeTime - GetProps (0x80004005) failed
[20048] (09/23 00:01:43.593):{0x25E0} CalICSAgent:: - LoadSyncInfo Open Root Folder(0x80040115) failed for
[20043] (09/23 00:01:43.593):{0x25E0} CalICSAgent::smileyfrustrated:ynch: Could not reload synchronization state for
[30243] (09/23 00:01:43.593):{0x25E0} {@mydomain.co.uk} MAPIMailbox::smileyvery-happy:oICS ICS Synch failed
[20280] (09/23 00:01:43.593):{0x25E0} {@mydomain.co.uk} DoICS() failed: ERR_FAIL
[20265] (09/23 00:01:43.593):{0x277C} {@mydomain.co.uk} MAPIMailbox::GetNewMessages - GetProps (0x80040115) failed
[20001] (09/23 00:01:43.593):{0x25E0} {@mydomain.co.uk} CalSyncState::GetSyncStateTable - GetContentsTable(0x80040115) failed
[20265] (09/23 00:01:43.593):{0x277C} {k@mydomain.co.uk} MAPIMailbox::GetNewMessages - GetContentsTable (0x80040115) failed
[40720] (09/23 00:01:43.593):{0x25E0} MAPI call failed. Error 'Network problems are preventing connection to the Microsoft Exchange Server computer.', LowLevelError 1702, Component 'Microsoft Exchange Server Information Store', Context 1300
[20004] (09/23 00:01:43.593):{0x25E0} {@mydomain.co.uk} CalSyncState::QueryByRefId - GetSyncStateTable failed
[40720] (09/23 00:01:43.593):{0x277C} MAPI call failed. Error 'Network problems are preventing connection to the Microsoft Exchange Server computer.',

 

Guru III
knottyrope
Posts: 30,785
Registered: ‎06-25-2008
My Device:

I'm rockin the BlackBerry Passport, Z30, Z10, Q10, BlackBerry Mini Stereo Speaker, 64 gig PlayBook, BlackBerry Wireless Headset HS-700

My Carrier: I am on AT&T. Please edit your Personal Profile with your DEVICE TYPE, DEVICE OS and Carrier

Re: Logs plus MAGT

I would try this first

 

How to recreate the BlackBerry Enterprise Server MAPI profile

 




Click here to Backup the data on your BlackBerry Device! It's important, and FREE!


Click "Accept as Solution" if your problem is solved. To give thanks, click thumbs up
Click to search the Knowledge Base at BTSC and click to Read The Fabulous Manuals

BESAdmin's, please make a signature with your BES environment info.


SIM Free BlackBerry Unlocking FAQ
Follow me on Twitter @knottyrope


Want to thank me? Buy my KnottyRope App here


BES 12 and BES 5.0.4 with Exchange 2010 and SQL 2012 Hyper V


Guru III
knottyrope
Posts: 30,785
Registered: ‎06-25-2008
My Device:

I'm rockin the BlackBerry Passport, Z30, Z10, Q10, BlackBerry Mini Stereo Speaker, 64 gig PlayBook, BlackBerry Wireless Headset HS-700

My Carrier: I am on AT&T. Please edit your Personal Profile with your DEVICE TYPE, DEVICE OS and Carrier

Re: Logs plus MAGT

I would also upgrade CDO as well. 8244 is out

CDO 1.2.1 from here
http://www.microsoft.com/downloads/details.aspx?FamilyID=94274318-27c4-4d8d-9bc5-3e6484286b1f&Displa...

 

 

 

KB15779 How to install or upgrade CDO 1.2.1


 

 




Click here to Backup the data on your BlackBerry Device! It's important, and FREE!


Click "Accept as Solution" if your problem is solved. To give thanks, click thumbs up
Click to search the Knowledge Base at BTSC and click to Read The Fabulous Manuals

BESAdmin's, please make a signature with your BES environment info.


SIM Free BlackBerry Unlocking FAQ
Follow me on Twitter @knottyrope


Want to thank me? Buy my KnottyRope App here


BES 12 and BES 5.0.4 with Exchange 2010 and SQL 2012 Hyper V


New Contributor
ichibanto
Posts: 4
Registered: ‎09-22-2012
My Device: 9360

Re: Email delivery issues

Thank you so much. Mapi issues triggered by earlier cas issues. Plus DC time skew caused issues. Cheers.
Guru III
knottyrope
Posts: 30,785
Registered: ‎06-25-2008
My Device:

I'm rockin the BlackBerry Passport, Z30, Z10, Q10, BlackBerry Mini Stereo Speaker, 64 gig PlayBook, BlackBerry Wireless Headset HS-700

My Carrier: I am on AT&T. Please edit your Personal Profile with your DEVICE TYPE, DEVICE OS and Carrier

Re: Email delivery issues

glad to hear you are doing better

 




Click here to Backup the data on your BlackBerry Device! It's important, and FREE!


Click "Accept as Solution" if your problem is solved. To give thanks, click thumbs up
Click to search the Knowledge Base at BTSC and click to Read The Fabulous Manuals

BESAdmin's, please make a signature with your BES environment info.


SIM Free BlackBerry Unlocking FAQ
Follow me on Twitter @knottyrope


Want to thank me? Buy my KnottyRope App here


BES 12 and BES 5.0.4 with Exchange 2010 and SQL 2012 Hyper V