Hello all! I am running Blackberry Professional version 4.1.4 Bundle 143. I have a user trying to activate a Blackberry 8330 and the process stops at "Activating". It then tries over and over until it says activation failed see system administrator. I did find this link and have followed the steps outlined in the document but no such luck (
http://www.blackberry.com/btsc/search.do?cmd=displayKC&docType=kc&externalId=KB13852&sliceId=SAL_Pub...)
All the basic steps have been tried, removing the user, then stop and starting the router and Dispatcher. Removing the user then attempting to use DBclean -wipe, adding the user back to the system and setting an activation password. I then even tried to go into the host routing table and 'registering' the blackberry again which didn't seem to help. Turning off all Anti-spam software related to exchange, I am seeing the message sit in the mailbox then dissapear...
I also contacted the phone provider and from what I can gather they have the device provisioned correctly. Any assistance would be greatly appreciated!
Heres the log of whats going on:
------------
[30069] :54.237):{0xBC8}
{abc@user.com} Mailbox name is JohnBarno
[40221] :54.237):{0xBC8}
{abc@user.com} In Cradle timer is 725000
[40683] :54.252):{0x1740}
{abc@user.com} Updating the RefId generation number
[40684] :54.252):{0x1740}
{abc@user.com} Updating DataSourceId '5f31f4'
[40747] :54.268):{0xBC8} License total: 21, used = 3, free = 18
[30362] :54.268):{0xBC8} This agent will handle 3 user(s)
[30000] :54.268):{0xBC8} Optimize ThreadPools, total number of started users 3
[40413] :54.268):{0xBC8} Before optimization: total number of worker threads 3, where 2 non-removable
[40416] :54.268):{0xBC8} Thread pool for session 0x013425f8 (CPSVEXCH1) has 3 threads to serve 3 handhelds
[40417] :54.268):{0xBC8} After optimization: total number of worker threads 3, where 2 non-removable
[40861] :54.298):{0x1740}
{abc@user.com} New user added to the server - setting pending fields to this server's settings
[50094] :54.298):{0x1740} [AUDIT]
abc@user.com - User added to the BES
[40239] :54.298):{0x1740}
{abc@user.com} Still handled by desktop
[41079] :54.375):{0x1740}
{abc@user.com} PagerImp:

aveChanges: changed items = 23, 24, 45, 84, 86, 87, 88, 89, 95 Size = 2093
[40000] :54.406):{0x1740}
{abc@user.com} UserControl::UpdateMailboxITPolicy - Updating ITPolicy Information in the user's mailbox.
[30160] :54.406):{0x1740}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] :54.406):{0x1740}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[41079] :54.468):{0x1740}
{abc@user.com} PagerImp:

aveChanges: changed items = 38, 42, 44, 51, 52, 53, 59, 65, 75, 76, 77 Size = 62
[40442] :54.499):{0x1740} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=0, dir=JohnBarno, server=CPSVEXCH1
[30000] :54.499):{0x1740}
{abc@user.com} Sending data to Dispatcher, size=82, Tag=101493
[40000] :54.499):{0x1740}
{abc@user.com} SendToDispatcher, Tag=101493
[40000] :54.499):{0xA74} [BIPP] Send data, Tag=101493
[40000] :54.499):{0xAA8} [BIPP] Received status DELIVERED, Tag=101493
[40239] :54.499):{0xC44}
{abc@user.com} Still handled by desktop
[30160] :54.499):{0xC44}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] :54.499):{0xC44}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] :54.499):{0xC44} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=0, dir=JohnBarno, server=CPSVEXCH1
[40000] :54.499):{0x1740}
{abc@user.com} FindDeviceSendTransaction: transaction not found in current device send list, Tag=101493
[40000] :54.499):{0xAA8} [BIPP] Received datagram, Tag=62171
[40000] :54.499):{0xAA8} [BIPP] Received datagram, Tag=62172
[41079] :54.545):{0xC10}
{abc@user.com} PagerImp:

aveChanges: changed items = 96, 97 Size = 10029
[40845] :54.560):{0xC44}
{abc@user.com} SetPIMState - Registering for PIM synchronization (bState=1, bRet=1)
[30416] :54.560):{0xC44}
{abc@user.com} Established session with PIM Connector
[40799] :54.576):{0xC44}
{abc@user.com} Processed request from PIM Connector: cmd=0x5, Tag=62171
[40279] :54.576):{0xC44}
{abc@user.com} SubmitToRelaySendQ, Tag=62171
[40000] :54.576):{0xA74} [BIPP] Send status DATA_ACCEPTED, Tag=62171
[40239] :54.576):{0xC44}
{abc@user.com} Still handled by desktop
[30160] :54.576):{0xC44}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] :54.576):{0xC44}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] :54.576):{0xC44} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=0, dir=JohnBarno, server=CPSVEXCH1
[40178] :04.037):{0x890}
{abc@user.com} MAPIMailbox:

nNotify - search complete event
[40178] :04.037):{0x890}
{abc@user.com} MAPIMailbox:

nNotify - search complete event
[40239] :48.295):{0xC44}
{abc@user.com} Still handled by desktop
[30160] :48.295):{0xC44}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] :48.295):{0xC44}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] :48.295):{0xC44} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=0, dir=JohnBarno, server=CPSVEXCH1
[40000] :53.673):{0xA74} [BIPP] Ping 1 sent
[40000] :53.704):{0xAA8} [BIPP] PingResponse 1 received
[40239] :44.925):{0x1740}
{abc@user.com} Still handled by desktop
[30160] :44.925):{0x1740}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] :44.925):{0x1740}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] :44.925):{0x1740} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=0, dir=JohnBarno, server=CPSVEXCH1
[40000] :53.251):{0xA74} [BIPP] Ping 2 sent
[40000] :53.251):{0xAA8} [BIPP] PingResponse 2 received
[40000] :53.089):{0xA74} [BIPP] Ping 3 sent
[40000] :53.089):{0xAA8} [BIPP] PingResponse 3 received
[40000] 15:01:52.849):{0xA74} [BIPP] Ping 4 sent
[40000] 15:01:52.849):{0xAA8} [BIPP] PingResponse 4 received
[30247] 15:02:46.509):{0x16B4} Server stats - Msgs: Forwarded 77568, Sent 11110, Pending 0, Expired 0, Filtered 551
[40423] 15:03:05.262):{0x890}
{abc@user.com} Queuing new mail through notification (external). EntryId=11186
[40724] 15:03:05.262):{0x1740}
{abc@user.com} Get record key for this MAPI object, EntryId=11186
[40435] 15:03:05.278):{0x1740}
{abc@user.com} Queuing new mail through notification. EntryId=11186. Msgs Pending 0
[40719] 15:03:05.309):{0x1740}
{abc@user.com} GetFolderIDFromList No folder ID in list for EntryID
[40282] 15:03:05.355):{0x1740}
{abc@user.com} Queuing DATA from
network@etp1006.etp.na.blackberry.net, Tag=933549472, EntryId=11186
[30083] 15:03:05.386):{0x1740}
{abc@user.com} Sent ETP:

TATUS to BlackBerry system, Tag=933549472
[40700] 15:03:05.386):{0xC10}
{abc@user.com} Receiving packet from device, size=474, TransactionId=-1122735266, Tag=933549472, content type=OTAKEYGEN, cmd=0x3
[40000] 15:03:05.418):{0xC10} *** OTAKEYGEN *** receiving KEY_REQUEST, transID = 1000287455
[40000] 15:03:05.418):{0xC10} *** OTAKEYGEN *** receiving ACTIVATION request, transID = 1000287455
[30000] 15:03:05.449):{0xC10}
{abc@user.com} Sending data to Dispatcher, size=80, Tag=101495
[40000] 15:03:05.449):{0xC10}
{abc@user.com} SendToDispatcher, Tag=101495
[40000] 15:03:05.449):{0xC10}
{abc@user.com} Generating AES256 key
[40000] 15:03:05.449):{0xA74} [BIPP] Send data, Tag=101495
[40000] 15:03:05.449):{0xAA8} [BIPP] Received status DELIVERED, Tag=101495
[41079] 15:03:05.495):{0xC10}
{abc@user.com} PagerImp:

aveChanges: changed items = 54, 70, 74, 85 Size = 277
[40000] 15:03:26.427):{0xC10} *** OTAKEYGEN *** sending KEY_ACCEPT transID = 1000287455
[40583] 15:03:26.427):{0xC10}
{abc@user.com} Sending packet to device, Size=251, Tag=101496, TransactionId=-901095374
[40279] 15:03:26.427):{0xC10}
{abc@user.com} SubmitToRelaySendQ, Tag=101496
[40279] 15:03:26.427):{0xC10}
{abc@user.com} SubmitToRelaySendQ, Tag=933549472
[40000] 15:03:26.427):{0xA74} [BIPP] Send data, Tag=101496
[40000] 15:03:26.427):{0xA74} [BIPP] Send status DATA_ACCEPTED, Tag=933549472
[40000] 15:03:26.427):{0xC44}
{abc@user.com} FindDeviceSendTransaction: transaction not found in current device send list, Tag=101495
[40239] 15:03:26.427):{0x1740}
{abc@user.com} Still handled by desktop
[30160] 15:03:26.427):{0x1740}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] 15:03:26.427):{0x1740}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40000] 15:03:26.474):{0xAA8} [BIPP] Received status FAILED, Tag=101496
[41079] 15:03:26.474):{0x1740}
{abc@user.com} PagerImp:

aveChanges: changed items = 91 Size = 8
[40442] 15:03:26.474):{0x1740} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=1, dir=JohnBarno, server=CPSVEXCH1
[40000] 15:03:26.474):{0xC10}
{abc@user.com} FindDeviceSendTransaction: transaction not found in current device send list, Tag=101496
[30000] 15:03:26.474):{0xC44}
{abc@user.com} Sending data to Dispatcher, size=328, Tag=101497
[40000] 15:03:26.474):{0xC44}
{abc@user.com} SendToDispatcher, Tag=101497
[40000] 15:03:26.474):{0xA74} [BIPP] Send data, Tag=101497
[40000] 15:03:26.474):{0xAA8} [BIPP] Received status DELIVERED, Tag=101497
[40239] 15:03:26.474):{0x1740}
{abc@user.com} Still handled by desktop
[30160] 15:03:26.474):{0x1740}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] 15:03:26.474):{0x1740}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] 15:03:26.474):{0x1740} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=1, dir=JohnBarno, server=CPSVEXCH1
[40000] 15:03:26.474):{0xC10}
{abc@user.com} FindDeviceSendTransaction: transaction not found in current device send list, Tag=101497
[40239] 15:03:43.951):{0xC10}
{abc@user.com} Still handled by desktop
[30160] 15:03:43.951):{0xC10}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] 15:03:43.951):{0xC10}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] 15:03:43.951):{0xC10} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=1, dir=JohnBarno, server=CPSVEXCH1
[40000] 15:04:26.277):{0xA74} [BIPP] Ping 5 sent
[40000] 15:04:26.277):{0xAA8} [BIPP] PingResponse 5 received
[40000] 15:05:26.206):{0xA74} [BIPP] Ping 6 sent
[40000] 15:05:26.222):{0xAA8} [BIPP] PingResponse 6 received
[30181] 15:05:43.108):{0x744} Performing system health check (BlackBerry Mailbox Agent 1 - BESX Version 4.1.4.40)
[40360] 15:05:43.108):{0x744} [BIPPa] Health: QSize=0, intMap=0
[40000] 15:05:51.505):{0xAA8} [BIPP] Received datagram, Tag=62173
[45009] 15:06:43.552):{0xBC8} More cache hit rate: 0.0%, requests: 0, adds: 1, size: 0.0/10.0 Mb
[45014] 15:06:43.552):{0xBC8} ExtMore cache hit rate: 0.0%, requests: 0, adds: 0, size: 0/20000
[40000] 15:06:51.433):{0xA74} [BIPP] Ping 7 sent
[40000] 15:06:51.433):{0xAA8} [BIPP] PingResponse 7 received
[40000] 15:07:37.379):{0xAA8} [BIPP] Received datagram, Tag=62174
[40239] 15:11:53.741):{0xC10}
{abc@user.com} Still handled by desktop
[30160] 15:11:53.741):{0xC10}
{abc@user.com} GetDeviceId() did not return a PIN, PIN currently is not set for this user.
[40371] 15:11:53.741):{0xC10}
{abc@user.com} UserControl::HandleDatabaseChange - CalSyncState is empty
[40442] 15:11:53.741):{0xC10} User settings:
email=abc@user.com,
routing=abc@user.com, service=, device=, calendar=0, MDS=1, userOTAFM=0, incradle=0, SMIME=0, sentItems=1, dir=JohnBarno, server=CPSVEXCH1
[40423] 15:16:58.776):{0x890}
{abc@user.com} Queuing new mail through notification (external). EntryId=18917
[40724] 15:16:58.776):{0xC44}
{abc@user.com} Get record key for this MAPI object, EntryId=18917
[40435] 15:16:58.791):{0xC44}
{abc@user.com} Queuing new mail through notification. EntryId=18917. Msgs Pending 0
[30084] 15:16:58.807):{0xC44}
{abc@user.com} Ignored - let other server/desktop do it, EntryId=18917
[40000] 15:17:00.048):{0xA74} [BIPP] Ping 15 sent
[40000] 15:17:00.048):{0xAA8} [BIPP] PingResponse 15 received
[45009] 15:17:42.931):{0xBC8} More cache hit rate: 0.0%, requests: 0, adds: 1, size: 0.0/10.0 Mb
[45014] 15:17:42.931):{0xBC8} ExtMore cache hit rate: 0.0%, requests: 0, adds: 0, size: 0/20000
[40000] 15:17:59.647):{0xA74} [BIPP] Ping 16 sent
[40000] 15:17:59.647):{0xAA8} [BIPP] PingResponse 16 received