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.

inside custom component

BlackBerry® Enterprise Service 10

Reply
Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Devices not activating

Hi There

 

We are runnign BES 5.0 SP3 and are running int a problem when activating users. We can add the users to the BES not a problem and activate them. When we come to the devices we start the activation process but it sits there are waiting for services for hours. To contine the activation process we have to restart the Policy service.

 

Any idea what could be causing this and how to get around it without restarting the service?

 

Thanks in advance.

David

Guru III
knottyrope
Posts: 30,777
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: Devices not activating

check the POLC logs?

 

default location :\Program Files\Research In Motion\BlackBerryEnterprise Server\Logs

Also look in event veiwer to seef if any errors or warnings pertain to your issue

Please post back the log info minus personal info

 




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


Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Re: Devices not activating

thanks for the reply. There doesn't seem to be anything that stands out in the event logs;

 

thanks for the reply. There doesn't seem to be anything that stands out in the event logs;

 

UTF-8 encoded
[30000] (09/06 09:27:39.653):{0x2254} Current Date: 2011/09/06
[30000] (09/06 09:27:39.653):{0x2254} [DIAG] EVENT=Thread_report, THREADID=0x2254, THREADNAME="DebugLogger"
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Current Process: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BlackBerryPolicyServer.exe
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Current Process logged on as: UK\besadminuk, Start Time: Sep 06 2011 09:27:38, Uptime (seconds): 1
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Current Process id: 7996
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Computer Host Name: W8UKBES, OS Version: 6.1, Build number 7600, ServicePack Major 0, ServicePack Minor 0
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Processor Identifier: Intel64 Family 6 Model 44 Stepping 2
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Processor Vendor Identifier: GenuineIntel
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Processor Name String: Intel(R) Xeon(R) CPU           E5620  @ 2.40GHz
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Number of Processors: 2
[30000] (09/06 09:27:39.653):{0x2254} [ENV] 72 percent of memory in use.
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Total size of physical memory: 3145272 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Size of physical memory available: 853936 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Size of the committed memory limit: 7859916 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Size of available memory to commit: 5309076 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Total size of the user mode portion of the virtual address space of the BES process: 2097024 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Size of unreserved and uncommitted memory in the user mode portion of the virtual address space of the BES process: 2033488 KB
[30000] (09/06 09:27:39.653):{0x2254} [ENV] Size of private memory of the BES process: 4416 KB
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Total HD bytes: 29957812224, Total free bytes = 12125904896
[30000] (09/06 09:27:39.668):{0x2254} [ENV] System up time: 5 days 17 hrs 50 mins 59 secs
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Local Time Zone: GMT Daylight Time (GMT+00:00)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] TCP/IP provider (Winsock) File Version: 6.1.7600.16385 (C:\Windows\System32\wsock32.dll)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Local machine IP Address = 10.64.1.107
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Winsock2 file: @%SystemRoot%\system32\nlasvc.dll,-1000, Version: 6.1.7600.16385 (C:\Windows\system32\NLAapi.dll)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Winsock2 file: @%SystemRoot%\system32\wshtcpip.dll,-60103, Version: 6.1.7600.16385 (C:\Windows\System32\mswsock.dll)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Winsock2 file: NTDS, Version: 6.1.7600.16385 (C:\Windows\System32\winrnr.dll)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Winsock2 file: @%SystemRoot%\system32\napinsp.dll,-1000, Version: 6.1.7600.16385 (C:\Windows\system32\napinsp.dll)
[30000] (09/06 09:27:39.668):{0x2254} [ENV] Microsoft XML Parser 6.0: C:\Windows\System32\msxml6.dll, Version: 6.30.7600.16723
[30000] (09/06 09:27:39.903):{0x2254} [ENV] MSSQL OLEDB provider is available: [SQLOLEDB]
[30000] (09/06 09:27:39.903):{0x2254} [ENV] SQLCLI provider is available: [SQLNCLI]
[30000] (09/06 09:27:39.903):{0x2254} [ENV] SQLCLI provider is available: [SQLNCLI10]
[30000] (09/06 09:27:39.903):{0x2254} [ENV] MDAC version: 6.1.7600.16385
[30000] (09/06 09:27:39.903):{0x2254} [ENV] MSADO15.DLL: C:\Program Files (x86)\Common Files\System\ado\msado15.dll, Version: 6.1.7600.16688
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: System, ID: 4
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: smss.exe, ID: 304
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: csrss.exe, ID: 408
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: wininit.exe, ID: 464
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: csrss.exe, ID: 472
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: winlogon.exe, ID: 508
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: services.exe, ID: 568
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: lsass.exe, ID: 576
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: lsm.exe, ID: 584
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 680
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 760
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 836
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: LogonUI.exe, ID: 848
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 892
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 928
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 976
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 1016
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 652
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: spoolsv.exe, ID: 1112
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BAS-NCC.exe, ID: 1252
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBAttachServer.exe, ID: 1276
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryController.exe, ID: 1300
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryDispatcher.exe, ID: 1344
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: bmds.exe, ID: 1444
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackberryRouter.exe, ID: 1480
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBAttachMonitor.exe, ID: 1632
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 1676
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BESAlert.exe, ID: 1744
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: NSClient++.exe, ID: 2004
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 2196
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: vds.exe, ID: 2248
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: vmtoolsd.exe, ID: 2368
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BAS-AS.exe, ID: 2696
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: ShadowProtectSvc.exe, ID: 2728
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: ShadowProtectSvc.exe, ID: 2804
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: VMUpgradeHelper.exe, ID: 2404
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: vsnapvss.exe, ID: 2484
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 3956
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 4008
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: msdtc.exe, ID: 4372
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerrySyncServer.exe, ID: 4684
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryExtension.exe, ID: 4808
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 4816
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryAgent.exe, ID: 4916
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 4924
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: CalHelperWS.exe, ID: 5536
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 5544
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: csrss.exe, ID: 6872
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: winlogon.exe, ID: 460
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: svchost.exe, ID: 5804
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: taskhost.exe, ID: 7892
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: rdpclip.exe, ID: 8012
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: dwm.exe, ID: 8080
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: explorer.exe, ID: 8104
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: VMwareTray.exe, ID: 8180
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: jusched.exe, ID: 7856
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: jucheck.exe, ID: 7164
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryMailStoreSrvr.exe, ID: 1900
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: ShadowProtect.exe, ID: 3012
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: notepad.exe, ID: 5452
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBConvert.exe, ID: 8832
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 8460
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBConvert.exe, ID: 7008
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 5672
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: LogonUI.exe, ID: 8416
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBConvert.exe, ID: 1696
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 9180
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BBConvert.exe, ID: 7344
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: conhost.exe, ID: 8068
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: mmc.exe, ID: 5092
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: iexplore.exe, ID: 7260
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: iexplore.exe, ID: 2204
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: RIMDeviceManager.exe, ID: 6568
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BbDevMgr.exe, ID: 7152
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: dllhost.exe, ID: 6952
[30000] (09/06 09:27:39.918):{0x2254} [ENV] Running Process: BlackBerryPolicyServer.exe, ID: 7996
[40000] (09/06 09:27:39.918):{0x2254} [DIAG] EVENT=Syslog_connected, EVENTMSG="Connected to 127.0.0.1"
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerryPolicyServer Version 5.0.3.13
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BES Service Name: BlackBerry Policy Service
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Dispatcher: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BlackBerryDispatcher.exe, Version: 5.0.3.13
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry User Administration Service: NOT FOUND
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry MDS Connection Service: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\MDS\bin\bmds.exe, Version: 5.0.3.57
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Database Consistency Service: NOT FOUND
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Policy Service: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BlackBerryPolicyServer.exe, Version: 5.0.3.13
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Synchronization Service: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\SyncServer\BlackBerrySyncServer.exe, Version: 5.0.3.19
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Router: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe, Version: 5.0.3.13
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Controller: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BlackBerryController.exe, Version: 5.0.3.22
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Alert: C:\Program Files (x86)\Research In Motion\BlackBerry Enterprise Server\BESAlert.exe, Version: 5.0.3.14
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] BlackBerry Attachment Service is installed remotely on
[45060] (09/06 09:27:39.981):{0x10A4} {ConnectionPool::ValidatePool}: Pool is not initialized
[30000] (09/06 09:27:39.981):{0x10A4} [ENV] [DB] SQLServer hostname: w3uksql03, Database name: BESMgmtUK
[40000] (09/06 09:27:39.981):{0x10A4} SCS::InitializeSystem - Registry Settings: GuestBESName is w8ukbes.uk.domaingroup.lan.
[50000] (09/06 09:27:39.981):{0x10A4} SCS::InitializeSystem - Starting BlackBerry Policy Server - Version 5.0.3.13
[30000] (09/06 09:27:40.074):{0x10A4} SCS::InitializeSystem - BES Cryptographic Kernel module is initialized and working properly.
[30000] (09/06 09:27:40.074):{0x10A4} SCS::InitializeSystem - Loading Registry settings
[30000] (09/06 09:27:40.074):{0x10A4} SCS::InitializeSystem - Creating Connection Pool
[30000] (09/06 09:27:40.074):{0x10A4} ADO ConnectionTimeout value = 30s
[30000] (09/06 09:27:40.074):{0x10A4} ADO ConnectionTimeout for re-initalizing the pool = 45s
[45059] (09/06 09:27:40.090):{0x10A4} {ConnectionPool::smileytongue:ostConnectWork()}: Using connection pool with limit of 100 connections
[30000] (09/06 09:27:40.106):{0x10A4} [ENV] [DB] Connection String = Server=w3uksql03;Database=BESMgmtUK;Network=dbmssocn;Trusted_Connection=Yes
[30000] (09/06 09:27:40.106):{0x10A4} [ENV] [DB] DBMS Name = Microsoft SQL Server;  DBMS Version = 09.00.5057;  Provider Name = sqlncli.dll;  Provider Friendly Name = Microsoft SQL Native Client;  OLE DB Version = 02.80;  Provider Version = 9.00.3042.00;  Failover Partner =
[35019] (09/06 09:27:40.106):{0x10A4} [ENV] [DB] Database Schema Version:  5.0.3 <5.0.2011.02.11>
[40000] (09/06 09:27:40.121):{0x10A4} SCS::LogPolicyConfig - m_bDisableUserWithUnappliedITPolicy False, m_nDisableUserTimeLimit 432000 seconds, Server security settings are set to Primary BES
[30000] (09/06 09:27:40.137):{0x10A4} CreateXMLSBServerCapabilities - Generating XML-SB server capabilities
[30000] (09/06 09:27:40.137):{0x10A4} ADO ConnectionTimeout value = 30s
[30000] (09/06 09:27:40.137):{0x10A4} ADO ConnectionTimeout for re-initalizing the pool = 45s
[20000] (09/06 09:27:40.215):{0x10A4} SCS::RequeueInProgressCommands - 4 commands were requeued
[45179] (09/06 09:27:40.231):{0x10A4} SNMP monitoring started
[30000] (09/06 09:27:40.231):{0x10A4} SCS::InitializeSystem - Starting Database
[20608] (09/06 09:27:40.246):{0x10A4} [BIPPe] WARNING: Using default BIPP shared secret
[30000] (09/06 09:27:40.246):{0x10A4} [BIPP] Starting client 'BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange' with UID T47539710:C3,ITADMIN,APPD,SERVICE_BOOK,OTASL
[35001] (09/06 09:27:40.246):{0x10A4} [BIPP] Using AES256 encryption for BIPP Client
[40000] (09/06 09:27:40.246):{0x10A4} SCS::InitializeSystem - Using SRP Transport.
[30000] (09/06 09:27:40.246):{0x10A4} SCS::InitializeSystem - Starting Request Handlers
[30000] (09/06 09:27:40.246):{0x156C} [DIAG] EVENT=Register_thread, THREADID=0x156C, THREADNAME="BIPPe_ClientSessionReceiver"
[40000] (09/06 09:27:40.246):{0x156C} BIPPe_ClientSessionReceiver thread Id=0x156C, Handle=0x4a0
[30000] (09/06 09:27:40.246):{0x10A4} SCS::InitializeSystem - All Request Handlers started
[30000] (09/06 09:27:40.246):{0x23EC} [DIAG] EVENT=Register_thread, THREADID=0x23EC, THREADNAME="BIPPe_ClientSession"
[40000] (09/06 09:27:40.246):{0x10A4} SCS::InitializeSystem - Starting a thread pool with 5 threads
[40000] (09/06 09:27:40.246):{0x23EC} BIPPe_ClientSession thread Id=0x23EC, Handle=0x4a4
[45001] (09/06 09:27:40.246):{0x23EC} [BIPP] Connecting to "localhost"
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[30000] (09/06 09:27:40.246):{0x5B4} [DIAG] EVENT=Register_thread, THREADID=0x5B4, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[30000] (09/06 09:27:40.246):{0x1C60} [DIAG] EVENT=Register_thread, THREADID=0x1C60, THREADNAME="TimerThread"
[40000] (09/06 09:27:40.246):{0x1C60} [DEBUG] EVENTMSG="TimerThread thread started"
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[40000] (09/06 09:27:40.246):{0x10A4} SCS::InitializeSystem - Starting the atomic thread pool with 1 thread
[30000] (09/06 09:27:40.246):{0x10A4} RequestHandler starting up
[40000] (09/06 09:27:40.246):{0x23EC} BIPPeClient::Connect: Found 1 addresses for host "localhost"
[40000] (09/06 09:27:40.246):{0x10A4} DBChangeMonitor::smileyfrustrated:etupDBNS - Adding table mdsconfig - table ID 400 for DBNS monitoring
[40000] (09/06 09:27:40.246):{0x23EC} BIPPeClient::Connect: Host "localhost" @ [127.0.0.1]
[40000] (09/06 09:27:40.246):{0x10A4} DBChangeMonitor::smileyfrustrated:etupDBNS - Adding table imconfig - table ID 460 for DBNS monitoring
[40000] (09/06 09:27:40.246):{0x23EC} BIPPeClient::Connect: Trying "localhost" @ [127.0.0.1]
[40000] (09/06 09:27:40.246):{0x10A4} DBChangeMonitor::smileyfrustrated:etupDBNS - Adding table mdsagconfig - table ID 480 for DBNS monitoring
[30000] (09/06 09:27:40.246):{0x1314} [DIAG] EVENT=Register_thread, THREADID=0x1314, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.246):{0xA40} [DIAG] EVENT=Register_thread, THREADID=0xA40, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.246):{0x1FD0} [DIAG] EVENT=Register_thread, THREADID=0x1FD0, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.246):{0x1B6C} [DIAG] EVENT=Register_thread, THREADID=0x1B6C, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.246):{0x2194} [DIAG] EVENT=Register_thread, THREADID=0x2194, THREADNAME="UserWorkerThread<PolicyServer>"
[30000] (09/06 09:27:40.262):{0x1624} [DIAG] EVENT=Register_thread, THREADID=0x1624, THREADNAME="DBNS Receiver Thread"
[45012] (09/06 09:27:40.262):{0x1624} Waiting for external UDP log messages on port 4187
[20000] (09/06 09:27:40.262):{0x10A4} {NotifyDatabase} :  DBNS component is not installed.
[40000] (09/06 09:27:40.278):{0x23EC} BIPPeClient::Authenticate: Authentication successful
[40000] (09/06 09:27:40.278):{0x23EC} [BIPP] Send info, Reason=2
[30496] (09/06 09:27:40.278):{0x23EC} Sending REPORT_HEALTH_SCORE command to Dispatcher, Health=0x0000000000100000, Mask=0x0000000000100000
[30156] (09/06 09:27:40.278):{0x23EC} [BIPPe] Connection established
[30000] (09/06 09:27:40.278):{0x23F0} [DIAG] EVENT=Register_thread, THREADID=0x23F0, THREADNAME="BIPPe_ClientReceiver"
[40000] (09/06 09:27:40.278):{0x23F0} BIPPe_ClientReceiver thread Id=0x23F0, Handle=0x53c
[30000] (09/06 09:27:40.293):{0x10A4} SCS::InitializeSystem - BlackBerry Policy Server started
[30000] (09/06 09:27:40.293):{0x22A0} [DIAG] EVENT=Register_thread, THREADID=0x22A0, THREADNAME="SCS"
[30000] (09/06 09:27:40.293):{0x1CAC} [DIAG] EVENT=Register_thread, THREADID=0x1CAC, THREADNAME="Unnamed"
[40000] (09/06 09:27:40.293):{0x1CAC} DBChangeMonitor::ThreadProc - Starting...
[40000] (09/06 09:27:40.293):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 09:27:40.293):{0x20C8} [DIAG] EVENT=Register_thread, THREADID=0x20C8, THREADNAME="TimerHealth"
[40000] (09/06 09:27:40.293):{0x22A0} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.293):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.309):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=91
[40000] (09/06 09:27:40.309):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::QueueServiceBooksForUsers - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:40.309):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.309):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}SCS::QueueServiceBooksForUsers - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:40.324):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:27:40.324):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=469
[40000] (09/06 09:27:40.324):{0x23EC} [BIPP] Send cancel, Tag=469
[40000] (09/06 09:27:40.324):{0x156C} [BIPP] Received status CANCELLED, Tag=469
[40340] (09/06 09:27:40.324):{0x156C} [BIPPe] Failed to find packet for received status, Tag=469
[40000] (09/06 09:27:40.324):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 09:27:40.324):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478148, SRPID=SRPID, Tag=473
[40000] (09/06 09:27:40.324):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=473
[40000] (09/06 09:27:40.324):{0x23EC} [BIPP] Send data, Tag=473
[40000] (09/06 09:27:40.324):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=93
[40000] (09/06 09:27:40.324):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0xA40} {TSullivan@domain.uk.com, PIN=PINNO., UserId=85}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0x22A0} {DBant@domain.uk.com, PIN=PINNO., UserId=89}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0x22A0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.340):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:27:40.340):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=470
[30000] (09/06 09:27:40.340):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478148, SRPID=SRPID, Tag=474
[40000] (09/06 09:27:40.340):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=474
[40000] (09/06 09:27:40.356):{0x23EC} [BIPP] Send cancel, Tag=470
[40000] (09/06 09:27:40.356):{0x23EC} [BIPP] Send data, Tag=474
[40000] (09/06 09:27:40.356):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.356):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:27:40.356):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=468
[30000] (09/06 09:27:40.356):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478148, SRPID=SRPID, Tag=475
[40000] (09/06 09:27:40.356):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=475
[40000] (09/06 09:27:40.356):{0x23EC} [BIPP] Send cancel, Tag=468
[40000] (09/06 09:27:40.356):{0x23EC} [BIPP] Send data, Tag=475
[40000] (09/06 09:27:40.371):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:27:40.371):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=471
[30000] (09/06 09:27:40.371):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478148, SRPID=SRPID, Tag=476
[40000] (09/06 09:27:40.371):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=476
[40000] (09/06 09:27:40.371):{0x23EC} [BIPP] Send cancel, Tag=471
[40000] (09/06 09:27:40.371):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:27:40.371):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=470
[30000] (09/06 09:27:40.371):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478147, SRPID=SRPID, Tag=477
[40000] (09/06 09:27:40.371):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=477
[40000] (09/06 09:27:40.371):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.371):{0x23EC} [BIPP] Send data, Tag=476
[40000] (09/06 09:27:40.371):{0x23EC} [BIPP] Send cancel, Tag=470
[40000] (09/06 09:27:40.371):{0x23EC} [BIPP] Send data, Tag=477
[40000] (09/06 09:27:40.371):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:40.371):{0x1314} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:27:42.418):{0x156C} [BIPP] Received status DELIVERED, Tag=475
[40000] (09/06 09:27:42.418):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:27:42.418):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=475
[40000] (09/06 09:27:42.418):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=475
[40000] (09/06 09:27:42.418):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:27:42.699):{0x156C} [BIPP] Received status DELIVERED, Tag=474
[40000] (09/06 09:27:42.699):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:27:42.699):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=474
[40000] (09/06 09:27:42.699):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=474
[40000] (09/06 09:27:42.699):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:27:43.012):{0x156C} [BIPP] Received status DELIVERED, Tag=477
[40000] (09/06 09:27:43.012):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:27:43.012):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=477
[40000] (09/06 09:27:43.012):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=477
[40000] (09/06 09:27:43.028):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:27:44.121):{0x156C} [BIPP] Received datagram, Tag=143499
[40000] (09/06 09:27:44.121):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:44.121):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024746, Tag=143499, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:27:44.121):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:27:44.121):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143499
[40000] (09/06 09:27:44.121):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:44.121):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143499
[40000] (09/06 09:27:44.309):{0x156C} [BIPP] Received datagram, Tag=143500
[40000] (09/06 09:27:44.309):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:44.309):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024744, Tag=143500, content type=OTASL, cmd=0x3
[40000] (09/06 09:27:44.309):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143500
[40000] (09/06 09:27:44.309):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:44.309):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143500
[40000] (09/06 09:27:45.809):{0x156C} [BIPP] Received datagram, Tag=143501
[40000] (09/06 09:27:45.809):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:45.809):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=1112519723, Tag=143501, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:27:45.809):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:27:45.825):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}SCS::smileyfrustrated:cheduleCommand - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:45.825):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143501
[40000] (09/06 09:27:45.825):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:45.825):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:45.825):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143501
[30000] (09/06 09:27:45.825):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 09:27:45.840):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - User specific values have changed for 1 user(s).  Service books will be resent to the users impacted
[30000] (09/06 09:27:45.840):{0x1CAC} SCS::ResendServiceBooks[users] -- Resending Service Books for 1 user(s) as user information has changed.
[40000] (09/06 09:27:45.840):{0x1CAC} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}SCS::QueueServiceBooksForUsers - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:45.856):{0x1B6C} SBBuilder::BuildServiceBooks - XML service books generated for userId=93 for service(s): ALP, BBIM, IPPP, MDS, OTASL, SYNC, FileBrowserConfig, CICAL, CMIME, ServiceConfig
[40000] (09/06 09:27:45.856):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=464
[40000] (09/06 09:27:45.856):{0x23EC} [BIPP] Send cancel, Tag=464
[30000] (09/06 09:27:45.856):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::FormatGMETransactionForDevice - Sending UPDATE_SERVICE_DATA_REQUEST request to device, contentType=SERVICE_BOOK, size=781, RefId=0, TransactionId=-9223372035539478148, SRPID=SRPID, Tag=478
[40000] (09/06 09:27:45.856):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=478
[40000] (09/06 09:27:45.856):{0x23EC} [BIPP] Send data, Tag=478
[40000] (09/06 09:27:45.856):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endServiceBooks - Sending service book data to device, Tag=478
[40000] (09/06 09:27:45.856):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:27:46.559):{0x156C} [BIPP] Received status DELIVERED, Tag=478
[40000] (09/06 09:27:46.559):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:27:46.559):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=478
[40000] (09/06 09:27:46.559):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command UPDATE_SERVICE_DATA - Processing packet, Tag=478
[40000] (09/06 09:27:46.559):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:27:46.825):{0x156C} [BIPP] Received datagram, Tag=143502
[40000] (09/06 09:27:46.825):{0xA40} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:46.825):{0xA40} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=49, TransactionId=1112519724, Tag=143502, content type=SERVICE_BOOK, cmd=0x3
[30000] (09/06 09:27:46.840):{0xA40} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::HandleSERVICE_BOOKDataCommand - UPDATE_SERVICE_DATA command Succeeded for entryid 295
[40000] (09/06 09:27:46.840):{0xA40} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143502
[40000] (09/06 09:27:46.840):{0xA40} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:46.840):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143502
[40000] (09/06 09:27:49.012):{0x156C} [BIPP] Received datagram, Tag=143504
[40000] (09/06 09:27:49.012):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:49.012):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=394, TransactionId=1112519726, Tag=143504, content type=OTASL, cmd=0x3
[40000] (09/06 09:27:49.012):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143504
[40000] (09/06 09:27:49.012):{0x1B6C} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:49.012):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143504
[40000] (09/06 09:27:49.043):{0x156C} [BIPP] Received datagram, Tag=143505
[40000] (09/06 09:27:49.043):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:49.043):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024741, Tag=143505, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:27:49.043):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:27:49.059):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143505
[40000] (09/06 09:27:49.059):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:49.059):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143505
[40000] (09/06 09:27:49.262):{0x156C} [BIPP] Received datagram, Tag=143506
[40000] (09/06 09:27:49.278):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:27:49.278):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024739, Tag=143506, content type=OTASL, cmd=0x3
[40000] (09/06 09:27:49.278):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143506
[40000] (09/06 09:27:49.278):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:27:49.278):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143506
[40000] (09/06 09:28:14.138):{0x156C} [BIPP] Received status DELIVERED, Tag=476
[40000] (09/06 09:28:14.138):{0x1B6C} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:28:14.138):{0x1B6C} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=476
[40000] (09/06 09:28:14.138):{0x1B6C} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=476
[40000] (09/06 09:28:14.138):{0x1B6C} {DBant@domain.uk.com, PIN=PINNO., UserId=89}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:28:40.294):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=91
[40000] (09/06 09:28:40.294):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:28:40.310):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 1, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
[40000] (09/06 09:28:40.310):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:28:40.310):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=477
[40000] (09/06 09:28:40.310):{0x23EC} [BIPP] Send cancel, Tag=477
[30000] (09/06 09:28:40.310):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478147, SRPID=SRPID, Tag=479
[40000] (09/06 09:28:40.310):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=479
[40000] (09/06 09:28:40.310):{0x23EC} [BIPP] Send data, Tag=479
[40000] (09/06 09:28:40.326):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:28:40.763):{0x156C} [BIPP] Received status DELIVERED, Tag=479
[40000] (09/06 09:28:40.763):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:28:40.763):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=479
[40000] (09/06 09:28:40.779):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=479
[40000] (09/06 09:28:40.779):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:28:42.388):{0x156C} [BIPP] Received datagram, Tag=143520
[40000] (09/06 09:28:42.388):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:28:42.388):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024735, Tag=143520, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:28:42.388):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:28:42.404):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:28:42.404):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143520
[40000] (09/06 09:28:42.404):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:28:42.404):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:28:42.404):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143520
[30000] (09/06 09:28:42.404):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 09:28:42.435):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - No changes detected.
[40000] (09/06 09:28:42.435):{0x5B4} SBBuilder::BuildServiceBooks - XML service books generated for userId=91 for service(s): ALP, BBIM, IPPP, MDS, OTASL, SYNC, FileBrowserConfig, CICAL, CMIME, ServiceConfig
[30000] (09/06 09:28:42.435):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending UPDATE_SERVICE_DATA_REQUEST request to device, contentType=SERVICE_BOOK, size=781, RefId=0, TransactionId=-9223372035539478146, SRPID=SRPID, Tag=480
[40000] (09/06 09:28:42.435):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=480
[40000] (09/06 09:28:42.435):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endServiceBooks - Sending service book data to device, Tag=480
[40000] (09/06 09:28:42.435):{0x23EC} [BIPP] Send data, Tag=480
[40000] (09/06 09:28:42.451):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:28:42.607):{0x156C} [BIPP] Received datagram, Tag=143521
[40000] (09/06 09:28:42.607):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:28:42.607):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024733, Tag=143521, content type=OTASL, cmd=0x3
[40000] (09/06 09:28:42.607):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143521
[40000] (09/06 09:28:42.607):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:28:42.607):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143521
[40000] (09/06 09:28:42.919):{0x156C} [BIPP] Received status DELIVERED, Tag=480
[40000] (09/06 09:28:42.919):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:28:42.919):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=480
[40000] (09/06 09:28:42.919):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command UPDATE_SERVICE_DATA - Processing packet, Tag=480
[40000] (09/06 09:28:42.919):{0x1B6C} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:28:43.466):{0x156C} [BIPP] Received datagram, Tag=143522
[40000] (09/06 09:28:43.466):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:28:43.466):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=49, TransactionId=-1488024731, Tag=143522, content type=SERVICE_BOOK, cmd=0x3
[30000] (09/06 09:28:43.466):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleSERVICE_BOOKDataCommand - UPDATE_SERVICE_DATA command Succeeded for entryid 293
[40000] (09/06 09:28:43.466):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143522
[40000] (09/06 09:28:43.466):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:28:43.466):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143522
[40000] (09/06 09:29:35.139):{0x156C} [BIPP] Received datagram, Tag=143543
[40000] (09/06 09:29:35.139):{0xA40} {NFarrington@domain.uk.com, PIN=PINNO., UserId=92}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:29:35.139):{0xA40} {NFarrington@domain.uk.com, PIN=PINNO., UserId=92}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=394, TransactionId=1213255888, Tag=143543, content type=OTASL, cmd=0x3
[40000] (09/06 09:29:35.139):{0xA40} {NFarrington@domain.uk.com, PIN=PINNO., UserId=92}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143543
[40000] (09/06 09:29:35.139):{0xA40} {NFarrington@domain.uk.com, PIN=PINNO., UserId=92}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:29:35.139):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143543
[40000] (09/06 09:29:40.295):{0x22A0} 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/06 09:30:35.156):{0x23EC} [BIPP] Ping 0 sent
[40000] (09/06 09:30:35.156):{0x156C} [BIPP] Ping Response 0 received
[40000] (09/06 09:30:40.297):{0x22A0} 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/06 09:31:35.173):{0x23EC} [BIPP] Ping 1 sent
[40000] (09/06 09:31:35.173):{0x156C} [BIPP] Ping Response 1 received
[40000] (09/06 09:31:40.313):{0x22A0} 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/06 09:32:35.189):{0x23EC} [BIPP] Ping 2 sent
[40000] (09/06 09:32:35.189):{0x156C} [BIPP] Ping Response 2 received
[40000] (09/06 09:32:40.299):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:32:40.315):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:32:40.315):{0x22A0} 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/06 09:33:35.191):{0x23EC} [BIPP] Ping 3 sent
[40000] (09/06 09:33:35.191):{0x156C} [BIPP] Ping Response 3 received
[40000] (09/06 09:33:40.316):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 1, QueueInterval (ms) 60000.
[40000] (09/06 09:33:40.316):{0x22A0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:33:40.316):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:33:40.331):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Redundant policy send ignored.
[30000] (09/06 09:33:40.331):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478145, SRPID=SRPID, Tag=481
[40000] (09/06 09:33:40.331):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=481
[40000] (09/06 09:33:40.331):{0x23EC} [BIPP] Send data, Tag=481
[40000] (09/06 09:33:40.331):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:33:40.613):{0x156C} [BIPP] Received status DELIVERED, Tag=481
[40000] (09/06 09:33:40.628):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:33:40.628):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=481
[40000] (09/06 09:33:40.628):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=481
[40000] (09/06 09:33:40.628):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:33:42.300):{0x156C} [BIPP] Received datagram, Tag=143573
[40000] (09/06 09:33:42.316):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:33:42.316):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024721, Tag=143573, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:33:42.316):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:33:42.316):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143573
[40000] (09/06 09:33:42.316):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:33:42.316):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143573
[40000] (09/06 09:33:42.550):{0x156C} [BIPP] Received datagram, Tag=143574
[40000] (09/06 09:33:42.550):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:33:42.550):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024719, Tag=143574, content type=OTASL, cmd=0x3
[40000] (09/06 09:33:42.550):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143574
[40000] (09/06 09:33:42.550):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:33:42.550):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143574
[40000] (09/06 09:34:40.332):{0x22A0} 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/06 09:34:42.551):{0x23EC} [BIPP] Ping 4 sent
[40000] (09/06 09:34:42.551):{0x156C} [BIPP] Ping Response 4 received
[40000] (09/06 09:35:40.349):{0x22A0} 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/06 09:35:42.552):{0x23EC} [BIPP] Ping 5 sent
[40000] (09/06 09:35:42.552):{0x156C} [BIPP] Ping Response 5 received
[40000] (09/06 09:36:40.350):{0x22A0} 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/06 09:36:42.554):{0x23EC} [BIPP] Ping 6 sent
[40000] (09/06 09:36:42.554):{0x156C} [BIPP] Ping Response 6 received
[40000] (09/06 09:37:40.320):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[30181] (09/06 09:37:40.320):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 09:37:40.336):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::QueueServiceBooksForUsers - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:37:40.336):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:37:40.352):{0x22A0} 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/06 09:37:40.352):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=91
[40000] (09/06 09:37:40.352):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:37:40.383):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 09:37:40.383):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=481
[40000] (09/06 09:37:40.383):{0x23EC} [BIPP] Send cancel, Tag=481
[30000] (09/06 09:37:40.383):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478144, SRPID=SRPID, Tag=482
[40000] (09/06 09:37:40.383):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=482
[40000] (09/06 09:37:40.383):{0x23EC} [BIPP] Send data, Tag=482
[40000] (09/06 09:37:40.383):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:37:42.148):{0x156C} [BIPP] Received status DELIVERED, Tag=482
[40000] (09/06 09:37:42.148):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:37:42.148):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=482
[40000] (09/06 09:37:42.148):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=482
[40000] (09/06 09:37:42.148):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:37:42.477):{0x156C} [BIPP] Received datagram, Tag=143646
[40000] (09/06 09:37:42.477):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:37:42.492):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024712, Tag=143646, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:37:42.492):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:37:42.492):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:37:42.492):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143646
[40000] (09/06 09:37:42.492):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:37:42.492):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:37:42.492):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143646
[30000] (09/06 09:37:42.492):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 09:37:42.523):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - User specific values have changed for 1 user(s).  Service books will be resent to the users impacted
[30000] (09/06 09:37:42.523):{0x1CAC} SCS::ResendServiceBooks[users] -- Resending Service Books for 1 user(s) as user information has changed.
[40000] (09/06 09:37:42.523):{0x1CAC} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::QueueServiceBooksForUsers - Queuing UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:37:42.539):{0x5B4} SBBuilder::BuildServiceBooks - XML service books generated for userId=91 for service(s): ALP, BBIM, IPPP, MDS, OTASL, SYNC, FileBrowserConfig, CICAL, CMIME, ServiceConfig
[40000] (09/06 09:37:42.539):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=480
[40000] (09/06 09:37:42.539):{0x23EC} [BIPP] Send cancel, Tag=480
[30000] (09/06 09:37:42.539):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending UPDATE_SERVICE_DATA_REQUEST request to device, contentType=SERVICE_BOOK, size=781, RefId=0, TransactionId=-9223372035539478143, SRPID=SRPID, Tag=483
[40000] (09/06 09:37:42.539):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=483
[40000] (09/06 09:37:42.539):{0x23EC} [BIPP] Send data, Tag=483
[40000] (09/06 09:37:42.539):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endServiceBooks - Sending service book data to device, Tag=483
[40000] (09/06 09:37:42.539):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed UPDATE_SERVICE_DATA_REQUEST request
[40000] (09/06 09:37:42.711):{0x156C} [BIPP] Received datagram, Tag=143647
[40000] (09/06 09:37:42.711):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:37:42.711):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024710, Tag=143647, content type=OTASL, cmd=0x3
[40000] (09/06 09:37:42.711):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143647
[40000] (09/06 09:37:42.711):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:37:42.711):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143647
[40000] (09/06 09:37:43.758):{0x156C} [BIPP] Received status DELIVERED, Tag=483
[40000] (09/06 09:37:43.773):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:37:43.773):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=483
[40000] (09/06 09:37:43.773):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command UPDATE_SERVICE_DATA - Processing packet, Tag=483
[40000] (09/06 09:37:43.773):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:37:44.039):{0x156C} [BIPP] Received datagram, Tag=143648
[40000] (09/06 09:37:44.039):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:37:44.039):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=49, TransactionId=-1488024708, Tag=143648, content type=SERVICE_BOOK, cmd=0x3
[30000] (09/06 09:37:44.039):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleSERVICE_BOOKDataCommand - UPDATE_SERVICE_DATA command Succeeded for entryid 293
[40000] (09/06 09:37:44.039):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143648
[40000] (09/06 09:37:44.039):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:37:44.039):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143648
[40000] (09/06 09:38:40.353):{0x22A0} 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/06 09:38:44.056):{0x23EC} [BIPP] Ping 7 sent
[40000] (09/06 09:38:44.056):{0x156C} [BIPP] Ping Response 7 received
[40000] (09/06 09:39:40.369):{0x22A0} 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/06 09:39:44.057):{0x23EC} [BIPP] Ping 8 sent
[40000] (09/06 09:39:44.057):{0x156C} [BIPP] Ping Response 8 received
[40000] (09/06 09:40:40.386):{0x22A0} 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/06 09:40:44.074):{0x23EC} [BIPP] Ping 9 sent
[40000] (09/06 09:40:44.074):{0x156C} [BIPP] Ping Response 9 received
[40000] (09/06 09:41:40.387):{0x22A0} 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/06 09:41:44.091):{0x23EC} [BIPP] Ping 10 sent
[40000] (09/06 09:41:44.091):{0x156C} [BIPP] Ping Response 10 received
[40000] (09/06 09:42:40.342):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:42:40.357):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:42:40.389):{0x22A0} 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.
[45013] (09/06 09:42:41.123):{0x1624} ExtUDPNtfThread: Code on closing = 0
[30000] (09/06 09:42:41.123):{0x1624} [DIAG] EVENT=Unregister_thread, THREADID=0x1624, THREADNAME="DBNS Receiver Thread"
[40000] (09/06 09:42:44.107):{0x23EC} [BIPP] Ping 11 sent
[40000] (09/06 09:42:44.107):{0x156C} [BIPP] Ping Response 11 received
[40000] (09/06 09:43:40.390):{0x22A0} 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/06 09:43:44.124):{0x23EC} [BIPP] Ping 12 sent
[40000] (09/06 09:43:44.124):{0x156C} [BIPP] Ping Response 12 received
[40000] (09/06 09:44:40.391):{0x22A0} 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/06 09:44:44.141):{0x23EC} [BIPP] Ping 13 sent
[40000] (09/06 09:44:44.141):{0x156C} [BIPP] Ping Response 13 received
[40000] (09/06 09:45:40.392):{0x22A0} 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/06 09:45:44.142):{0x23EC} [BIPP] Ping 14 sent
[40000] (09/06 09:45:44.142):{0x156C} [BIPP] Ping Response 14 received
[40000] (09/06 09:46:40.393):{0x22A0} 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/06 09:46:44.143):{0x23EC} [BIPP] Ping 15 sent
[40000] (09/06 09:46:44.143):{0x156C} [BIPP] Ping Response 15 received
[40000] (09/06 09:47:40.332):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 09:47:40.332):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[30181] (09/06 09:47:40.332):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 09:47:40.363):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:47:40.394):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:47:40.410):{0x22A0} 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/06 09:47:44.144):{0x23EC} [BIPP] Ping 16 sent
[40000] (09/06 09:47:44.144):{0x156C} [BIPP] Ping Response 16 received
[40000] (09/06 09:48:40.395):{0x22A0} 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/06 09:48:44.146):{0x23EC} [BIPP] Ping 17 sent
[40000] (09/06 09:48:44.146):{0x156C} [BIPP] Ping Response 17 received
[40000] (09/06 09:49:40.397):{0x22A0} 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/06 09:49:44.147):{0x23EC} [BIPP] Ping 18 sent
[40000] (09/06 09:49:44.147):{0x156C} [BIPP] Ping Response 18 received
[40000] (09/06 09:50:40.398):{0x22A0} 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/06 09:50:44.148):{0x23EC} [BIPP] Ping 19 sent
[40000] (09/06 09:50:44.148):{0x156C} [BIPP] Ping Response 19 received
[40000] (09/06 09:51:40.399):{0x22A0} 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/06 09:51:44.149):{0x23EC} [BIPP] Ping 20 sent
[40000] (09/06 09:51:44.149):{0x156C} [BIPP] Ping Response 20 received
[40000] (09/06 09:52:40.384):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:52:40.400):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:52:40.400):{0x22A0} 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/06 09:52:44.150):{0x23EC} [BIPP] Ping 21 sent
[40000] (09/06 09:52:44.150):{0x156C} [BIPP] Ping Response 21 received
[40000] (09/06 09:53:40.401):{0x22A0} 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/06 09:53:44.151):{0x23EC} [BIPP] Ping 22 sent
[40000] (09/06 09:53:44.151):{0x156C} [BIPP] Ping Response 22 received
[40000] (09/06 09:54:40.402):{0x22A0} 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/06 09:54:44.152):{0x23EC} [BIPP] Ping 23 sent
[40000] (09/06 09:54:44.152):{0x156C} [BIPP] Ping Response 23 received
[40000] (09/06 09:55:40.404):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 1, QueueInterval (ms) 60000.
[40000] (09/06 09:55:40.404):{0x22A0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:55:40.404):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 09:55:40.419):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileytongue:repareITAdminCommandForDevice - Redundant policy send ignored.
[30000] (09/06 09:55:40.419):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478142, SRPID=SRPID, Tag=484
[40000] (09/06 09:55:40.419):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=484
[40000] (09/06 09:55:40.419):{0x23EC} [BIPP] Send data, Tag=484
[40000] (09/06 09:55:40.435):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 09:55:44.154):{0x23EC} [BIPP] Ping 24 sent
[40000] (09/06 09:55:44.154):{0x156C} [BIPP] Ping Response 24 received
[40000] (09/06 09:56:08.998):{0x156C} [BIPP] Received status DELIVERED, Tag=484
[40000] (09/06 09:56:08.998):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 09:56:08.998):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=484
[40000] (09/06 09:56:08.998):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=484
[40000] (09/06 09:56:08.998):{0x1314} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 09:56:12.295):{0x156C} [BIPP] Received datagram, Tag=143819
[40000] (09/06 09:56:12.295):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:56:12.295):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=1112519765, Tag=143819, content type=ITADMIN, cmd=0x3
[30000] (09/06 09:56:12.295):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 09:56:12.295):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143819
[40000] (09/06 09:56:12.295):{0x1FD0} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:56:12.295):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143819
[40000] (09/06 09:56:17.982):{0x156C} [BIPP] Received datagram, Tag=143822
[40000] (09/06 09:56:17.982):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 09:56:17.982):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=394, TransactionId=1112519769, Tag=143822, content type=OTASL, cmd=0x3
[40000] (09/06 09:56:17.982):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143822
[40000] (09/06 09:56:17.982):{0x5B4} {RGrantSmith@domain.uk.com, PIN=PINNO., UserId=93}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 09:56:17.982):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143822
[40000] (09/06 09:56:40.405):{0x22A0} 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/06 09:57:17.999):{0x23EC} [BIPP] Ping 25 sent
[40000] (09/06 09:57:17.999):{0x156C} [BIPP] Ping Response 25 received
[40000] (09/06 09:57:40.343):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 09:57:40.343):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_UNAPPLIED_ITPOLICIES request
[30181] (09/06 09:57:40.343):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 09:57:40.343):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:57:40.343):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing QUEUE_STALE_ITPOLICIES request
[40000] (09/06 09:57:40.359):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed QUEUE_STALE_ITPOLICIES request
[40000] (09/06 09:57:40.359):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:57:40.390):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:57:40.390):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 09:57:40.406):{0x22A0} 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/06 09:58:18.016):{0x23EC} [BIPP] Ping 26 sent
[40000] (09/06 09:58:18.016):{0x156C} [BIPP] Ping Response 26 received
[40000] (09/06 09:58:40.407):{0x22A0} 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/06 09:59:18.033):{0x23EC} [BIPP] Ping 27 sent
[40000] (09/06 09:59:18.033):{0x156C} [BIPP] Ping Response 27 received
[40000] (09/06 09:59:40.408):{0x22A0} 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/06 10:00:18.034):{0x23EC} [BIPP] Ping 28 sent
[40000] (09/06 10:00:18.034):{0x156C} [BIPP] Ping Response 28 received
[40000] (09/06 10:00:40.409):{0x22A0} 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/06 10:01:18.035):{0x23EC} [BIPP] Ping 29 sent
[40000] (09/06 10:01:18.035):{0x156C} [BIPP] Ping Response 29 received
[40000] (09/06 10:01:40.410):{0x22A0} 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/06 10:02:18.036):{0x23EC} [BIPP] Ping 30 sent
[40000] (09/06 10:02:18.036):{0x156C} [BIPP] Ping Response 30 received
[40000] (09/06 10:02:40.412):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:02:40.427):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 1, QueueInterval (ms) 60000.
[40000] (09/06 10:02:40.427):{0x22A0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:02:40.427):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:02:40.427):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:02:40.443):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Redundant policy send ignored.
[30000] (09/06 10:02:40.443):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478141, SRPID=SRPID, Tag=485
[40000] (09/06 10:02:40.443):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=485
[40000] (09/06 10:02:40.443):{0x23EC} [BIPP] Send data, Tag=485
[40000] (09/06 10:02:40.443):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 10:02:43.224):{0x156C} [BIPP] Received status DELIVERED, Tag=485
[40000] (09/06 10:02:43.224):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 10:02:43.224):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=485
[40000] (09/06 10:02:43.224):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=485
[40000] (09/06 10:02:43.224):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 10:02:45.021):{0x156C} [BIPP] Received datagram, Tag=143851
[40000] (09/06 10:02:45.021):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 10:02:45.021):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024676, Tag=143851, content type=ITADMIN, cmd=0x3
[30000] (09/06 10:02:45.021):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 10:02:45.021):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143851
[40000] (09/06 10:02:45.021):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 10:02:45.021):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143851
[40000] (09/06 10:02:45.896):{0x156C} [BIPP] Received datagram, Tag=143853
[40000] (09/06 10:02:45.896):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 10:02:45.896):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024673, Tag=143853, content type=OTASL, cmd=0x3
[40000] (09/06 10:02:45.896):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143853
[40000] (09/06 10:02:45.896):{0x5B4} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 10:02:45.896):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143853
[40000] (09/06 10:03:40.413):{0x22A0} 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/06 10:03:45.913):{0x23EC} [BIPP] Ping 31 sent
[40000] (09/06 10:03:45.913):{0x156C} [BIPP] Ping Response 31 received
[40000] (09/06 10:04:40.414):{0x22A0} 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/06 10:04:45.914):{0x23EC} [BIPP] Ping 32 sent
[40000] (09/06 10:04:45.914):{0x156C} [BIPP] Ping Response 32 received
[40000] (09/06 10:05:40.415):{0x22A0} 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/06 10:05:45.915):{0x23EC} [BIPP] Ping 33 sent
[40000] (09/06 10:05:45.915):{0x156C} [BIPP] Ping Response 33 received
[40000] (09/06 10:06:40.416):{0x22A0} 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/06 10:06:45.916):{0x23EC} [BIPP] Ping 34 sent
[40000] (09/06 10:06:45.916):{0x156C} [BIPP] Ping Response 34 received
[30181] (09/06 10:07:40.370):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:07:40.370):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 10:07:40.370):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[40000] (09/06 10:07:40.417):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:07:40.417):{0x22A0} 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/06 10:07:40.433):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 10:07:42.558):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 10:07:42.574):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - No changes detected.
[40000] (09/06 10:07:45.917):{0x23EC} [BIPP] Ping 35 sent
[40000] (09/06 10:07:45.917):{0x156C} [BIPP] Ping Response 35 received
[40000] (09/06 10:08:40.419):{0x22A0} 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/06 10:08:45.919):{0x23EC} [BIPP] Ping 36 sent
[40000] (09/06 10:08:45.919):{0x156C} [BIPP] Ping Response 36 received
[40000] (09/06 10:09:40.420):{0x22A0} 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/06 10:09:45.920):{0x23EC} [BIPP] Ping 37 sent
[40000] (09/06 10:09:45.920):{0x156C} [BIPP] Ping Response 37 received
[40000] (09/06 10:10:40.421):{0x22A0} 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/06 10:10:45.921):{0x23EC} [BIPP] Ping 38 sent
[40000] (09/06 10:10:45.921):{0x156C} [BIPP] Ping Response 38 received
[40000] (09/06 10:11:40.422):{0x22A0} 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/06 10:11:45.922):{0x23EC} [BIPP] Ping 39 sent
[40000] (09/06 10:11:45.922):{0x156C} [BIPP] Ping Response 39 received
[40000] (09/06 10:12:40.423):{0x22A0} 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/06 10:12:40.423):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:12:40.439):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:12:45.923):{0x23EC} [BIPP] Ping 40 sent
[40000] (09/06 10:12:45.923):{0x156C} [BIPP] Ping Response 40 received
[40000] (09/06 10:13:40.424):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 0, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 1, QueueInterval (ms) 60000.
[40000] (09/06 10:13:40.424):{0x22A0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:13:40.424):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:13:40.440):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[30000] (09/06 10:13:40.440):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478147, SRPID=SRPID, Tag=486
[40000] (09/06 10:13:40.440):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=486
[40000] (09/06 10:13:40.440):{0x23EC} [BIPP] Send data, Tag=486
[40000] (09/06 10:13:40.440):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 10:13:43.143):{0x156C} [BIPP] Received status DELIVERED, Tag=486
[40000] (09/06 10:13:43.159):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 10:13:43.159):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=486
[40000] (09/06 10:13:43.159):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=486
[40000] (09/06 10:13:43.159):{0xA40} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 10:13:44.893):{0x156C} [BIPP] Received datagram, Tag=143906
[40000] (09/06 10:13:44.909):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 10:13:44.909):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=47, TransactionId=-1488024670, Tag=143906, content type=ITADMIN, cmd=0x3
[30000] (09/06 10:13:44.909):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::HandleITADMINDataCommandResult - Ack command SET_IT_POLICY_COMMAND
[40000] (09/06 10:13:44.909):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143906
[40000] (09/06 10:13:44.909):{0x1FD0} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 10:13:44.909):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143906
[40000] (09/06 10:13:45.659):{0x156C} [BIPP] Received datagram, Tag=143910
[40000] (09/06 10:13:45.674):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Processing NEW_MESSAGE request
[40000] (09/06 10:13:45.674):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oGMEReceiveProcessing - Receiving packet from device, size=392, TransactionId=-1488024667, Tag=143910, content type=OTASL, cmd=0x3
[40000] (09/06 10:13:45.674):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyfrustrated:endStatus - Submit ToRelaySendQ, Tag=143910
[40000] (09/06 10:13:45.674):{0x1314} {RChandarana@domain.uk.com, PIN=PINNO., UserId=91}RequestHandler::smileyvery-happy:oWork - Completed NEW_MESSAGE request
[40000] (09/06 10:13:45.674):{0x23EC} [BIPP] Send status DATA_ACCEPTED, Tag=143910
[40000] (09/06 10:14:40.425):{0x22A0} 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/06 10:14:45.676):{0x23EC} [BIPP] Ping 41 sent
[40000] (09/06 10:14:45.676):{0x156C} [BIPP] Ping Response 41 received
[40000] (09/06 10:15:40.427):{0x22A0} 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/06 10:15:45.677):{0x23EC} [BIPP] Ping 42 sent
[40000] (09/06 10:15:45.677):{0x156C} [BIPP] Ping Response 42 received
[40000] (09/06 10:16:40.428):{0x22A0} 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/06 10:16:45.678):{0x23EC} [BIPP] Ping 43 sent
[40000] (09/06 10:16:45.678):{0x156C} [BIPP] Ping Response 43 received
[30181] (09/06 10:17:40.398):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:17:40.429):{0x22A0} 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/06 10:17:40.429):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:17:40.460):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:17:45.679):{0x23EC} [BIPP] Ping 44 sent
[40000] (09/06 10:17:45.679):{0x156C} [BIPP] Ping Response 44 received
[40000] (09/06 10:18:40.430):{0x22A0} 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/06 10:18:45.680):{0x23EC} [BIPP] Ping 45 sent
[40000] (09/06 10:18:45.680):{0x156C} [BIPP] Ping Response 45 received
[40000] (09/06 10:19:40.431):{0x22A0} 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/06 10:19:45.681):{0x23EC} [BIPP] Ping 46 sent
[40000] (09/06 10:19:45.681):{0x156C} [BIPP] Ping Response 46 received
[40000] (09/06 10:20:40.432):{0x22A0} 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/06 10:20:45.682):{0x23EC} [BIPP] Ping 47 sent
[40000] (09/06 10:20:45.682):{0x156C} [BIPP] Ping Response 47 received
[40000] (09/06 10:21:40.433):{0x22A0} 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/06 10:21:45.684):{0x23EC} [BIPP] Ping 48 sent
[40000] (09/06 10:21:45.684):{0x156C} [BIPP] Ping Response 48 received
[40000] (09/06 10:22:40.435):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=34
[40000] (09/06 10:22:40.435):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:22:40.450):{0x22A0} SCS::smileytongue:ollDBQueueNewRequests - Change Detection Poll:  ProcessingRequests 1, LowerThreshold 30, ProcessingBESes 1, MaxDomainJobs 300, MaxJobsToSchedule 300, MaxBESJobs 100, MaxRequestsToQueue 100, Requests 0, QueueInterval (ms) 0.
[40000] (09/06 10:22:40.450):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:22:40.466):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[40000] (09/06 10:22:40.466):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyfrustrated:endCancel - Submit ToRelaySendQ, Tag=165
[40000] (09/06 10:22:40.466):{0x23EC} [BIPP] Send cancel, Tag=165
[30000] (09/06 10:22:40.466):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478146, SRPID=SRPID, Tag=487
[40000] (09/06 10:22:40.466):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=487
[40000] (09/06 10:22:40.466):{0x23EC} [BIPP] Send data, Tag=487
[40000] (09/06 10:22:40.466):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 10:22:40.482):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:22:45.685):{0x23EC} [BIPP] Ping 49 sent
[40000] (09/06 10:22:45.685):{0x156C} [BIPP] Ping Response 49 received
[40000] (09/06 10:23:11.873):{0x156C} [BIPP] Received status DELIVERED, Tag=487
[40000] (09/06 10:23:11.888):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 10:23:11.888):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=487
[40000] (09/06 10:23:11.888):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=487
[40000] (09/06 10:23:11.888):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 10:23:40.436):{0x22A0} 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/06 10:23:50.811):{0x156C} [BIPP] Ping 1 received
[40000] (09/06 10:23:50.811):{0x23EC} [BIPP] Send Ping Response 1
[40000] (09/06 10:24:40.437):{0x22A0} 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/06 10:24:50.812):{0x23EC} [BIPP] Ping 50 sent
[40000] (09/06 10:24:50.812):{0x156C} [BIPP] Ping Response 50 received
[40000] (09/06 10:25:40.438):{0x22A0} 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/06 10:25:50.813):{0x23EC} [BIPP] Ping 51 sent
[40000] (09/06 10:25:50.813):{0x156C} [BIPP] Ping Response 51 received
[40000] (09/06 10:26:40.439):{0x22A0} 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/06 10:26:50.814):{0x23EC} [BIPP] Ping 52 sent
[40000] (09/06 10:26:50.814):{0x156C} [BIPP] Ping Response 52 received
[40000] (09/06 10:27:40.394):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:27:40.394):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing QUEUE_STALE_ITPOLICIES request
[40000] (09/06 10:27:40.394):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 10:27:40.394):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 10:27:40.394):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 10:27:40.394):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[40000] (09/06 10:27:40.409):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed QUEUE_STALE_ITPOLICIES request
[30181] (09/06 10:27:40.409):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:27:40.409):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:27:40.440):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:27:40.440):{0x22A0} 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/06 10:27:40.456):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:27:50.816):{0x23EC} [BIPP] Ping 53 sent
[40000] (09/06 10:27:50.816):{0x156C} [BIPP] Ping Response 53 received
[40000] (09/06 10:28:40.442):{0x22A0} 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/06 10:28:50.817):{0x23EC} [BIPP] Ping 54 sent
[40000] (09/06 10:28:50.817):{0x156C} [BIPP] Ping Response 54 received
[40000] (09/06 10:29:40.443):{0x22A0} 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/06 10:29:50.818):{0x23EC} [BIPP] Ping 55 sent
[40000] (09/06 10:29:50.818):{0x156C} [BIPP] Ping Response 55 received
[40000] (09/06 10:30:40.444):{0x22A0} 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/06 10:30:50.819):{0x23EC} [BIPP] Ping 56 sent
[40000] (09/06 10:30:50.819):{0x156C} [BIPP] Ping Response 56 received
[40000] (09/06 10:31:40.445):{0x22A0} 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/06 10:31:50.820):{0x23EC} [BIPP] Ping 57 sent
[40000] (09/06 10:31:50.820):{0x156C} [BIPP] Ping Response 57 received
[40000] (09/06 10:32:40.446):{0x22A0} 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/06 10:32:40.446):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:32:40.462):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:32:50.821):{0x23EC} [BIPP] Ping 58 sent
[40000] (09/06 10:32:50.821):{0x156C} [BIPP] Ping Response 58 received
[40000] (09/06 10:33:40.447):{0x22A0} 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/06 10:33:50.823):{0x23EC} [BIPP] Ping 59 sent
[40000] (09/06 10:33:50.823):{0x156C} [BIPP] Ping Response 59 received
[40000] (09/06 10:34:40.448):{0x22A0} 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/06 10:34:50.824):{0x23EC} [BIPP] Ping 60 sent
[40000] (09/06 10:34:50.824):{0x156C} [BIPP] Ping Response 60 received
[40000] (09/06 10:35:40.450):{0x22A0} 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/06 10:35:50.825):{0x23EC} [BIPP] Ping 61 sent
[40000] (09/06 10:35:50.825):{0x156C} [BIPP] Ping Response 61 received
[40000] (09/06 10:36:40.451):{0x22A0} 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/06 10:36:50.826):{0x23EC} [BIPP] Ping 62 sent
[40000] (09/06 10:36:50.826):{0x156C} [BIPP] Ping Response 62 received
[30181] (09/06 10:37:40.436):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:37:40.452):{0x22A0} 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/06 10:37:40.452):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:37:40.468):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 10:37:42.624):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 10:37:42.624):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - No changes detected.
[40000] (09/06 10:37:50.827):{0x23EC} [BIPP] Ping 63 sent
[40000] (09/06 10:37:50.827):{0x156C} [BIPP] Ping Response 63 received
[40000] (09/06 10:38:40.453):{0x22A0} 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/06 10:38:50.828):{0x23EC} [BIPP] Ping 64 sent
[40000] (09/06 10:38:50.828):{0x156C} [BIPP] Ping Response 64 received
[40000] (09/06 10:39:40.454):{0x22A0} 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/06 10:39:40.454):{0x22A0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}SCS::smileyfrustrated:cheduleCommand - Queuing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:39:40.454):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:39:40.470):{0x22A0} SCS::CheckITPolicyInSBGroup - Queuing SET_ITPOLICY_REQUEST request for UserId=34
[40000] (09/06 10:39:40.470):{0x1FD0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing SET_ITPOLICY_REQUEST request
[40000] (09/06 10:39:40.485):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[30000] (09/06 10:39:40.485):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478145, SRPID=SRPID, Tag=488
[40000] (09/06 10:39:40.485):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=488
[40000] (09/06 10:39:40.485):{0x23EC} [BIPP] Send data, Tag=488
[40000] (09/06 10:39:40.485):{0xA40} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 10:39:40.501):{0x1FD0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileytongue:repareITAdminCommandForDevice - Preparing SET_ITPOLICY_REQUEST request using policy "domain Policy" for device
[30000] (09/06 10:39:40.501):{0x1FD0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::FormatGMETransactionForDevice - Sending SET_ITPOLICY_REQUEST request to device, contentType=ITADMIN, size=446, RefId=0, TransactionId=-9223372035539478147, SRPID=SRPID, Tag=489
[40000] (09/06 10:39:40.501):{0x1FD0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyfrustrated:endData - Submit ToRelaySendQ, PIN=PINNO., Tag=489
[40000] (09/06 10:39:40.501):{0x23EC} [BIPP] Send data, Tag=489
[40000] (09/06 10:39:40.501):{0x1FD0} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed SET_ITPOLICY_REQUEST request
[40000] (09/06 10:39:43.126):{0x156C} [BIPP] Received status DELIVERED, Tag=488
[40000] (09/06 10:39:43.126):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 10:39:43.126):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=488
[40000] (09/06 10:39:43.126):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=488
[40000] (09/06 10:39:43.126):{0x5B4} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 10:39:43.376):{0x156C} [BIPP] Received status DELIVERED, Tag=489
[40000] (09/06 10:39:43.376):{0x1314} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (09/06 10:39:43.376):{0x1314} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oDeviceSentProcessing - Message has been delivered to device, Tag=489
[40000] (09/06 10:39:43.376):{0x1314} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oITPolicyDeviceSentProcessing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=489
[40000] (09/06 10:39:43.376):{0x1314} {GAmatt@domain.uk.com, PIN=PINNO., UserId=34}RequestHandler::smileyvery-happy:oWork - Completed DEVICE_SEND_STATUS_EVENT request
[40000] (09/06 10:40:40.455):{0x22A0} 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/06 10:40:43.393):{0x23EC} [BIPP] Ping 65 sent
[40000] (09/06 10:40:43.393):{0x156C} [BIPP] Ping Response 65 received
[40000] (09/06 10:41:40.457):{0x22A0} 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/06 10:41:43.410):{0x23EC} [BIPP] Ping 66 sent
[40000] (09/06 10:41:43.410):{0x156C} [BIPP] Ping Response 66 received
[40000] (09/06 10:42:40.458):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:42:40.458):{0x22A0} 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/06 10:42:40.473):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:42:43.426):{0x23EC} [BIPP] Ping 67 sent
[40000] (09/06 10:42:43.426):{0x156C} [BIPP] Ping Response 67 received
[40000] (09/06 10:43:40.459):{0x22A0} 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/06 10:43:43.443):{0x23EC} [BIPP] Ping 68 sent
[40000] (09/06 10:43:43.443):{0x156C} [BIPP] Ping Response 68 received
[40000] (09/06 10:44:40.460):{0x22A0} 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/06 10:44:43.460):{0x23EC} [BIPP] Ping 69 sent
[40000] (09/06 10:44:43.460):{0x156C} [BIPP] Ping Response 69 received
[40000] (09/06 10:45:40.461):{0x22A0} 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/06 10:45:43.461):{0x23EC} [BIPP] Ping 70 sent
[40000] (09/06 10:45:43.461):{0x156C} [BIPP] Ping Response 70 received
[40000] (09/06 10:46:40.462):{0x22A0} 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/06 10:46:43.462):{0x23EC} [BIPP] Ping 71 sent
[40000] (09/06 10:46:43.462):{0x156C} [BIPP] Ping Response 71 received
[40000] (09/06 10:47:40.432):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 10:47:40.432):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[30181] (09/06 10:47:40.463):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:47:40.463):{0x22A0} 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/06 10:47:40.463):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:47:40.479):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:47:43.464):{0x23EC} [BIPP] Ping 72 sent
[40000] (09/06 10:47:43.464):{0x156C} [BIPP] Ping Response 72 received
[40000] (09/06 10:48:40.465):{0x22A0} 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/06 10:48:43.465):{0x23EC} [BIPP] Ping 73 sent
[40000] (09/06 10:48:43.465):{0x156C} [BIPP] Ping Response 73 received
[40000] (09/06 10:49:40.466):{0x22A0} 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/06 10:49:43.466):{0x23EC} [BIPP] Ping 74 sent
[40000] (09/06 10:49:43.466):{0x156C} [BIPP] Ping Response 74 received
[40000] (09/06 10:50:40.467):{0x22A0} 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/06 10:50:43.467):{0x23EC} [BIPP] Ping 75 sent
[40000] (09/06 10:50:43.467):{0x156C} [BIPP] Ping Response 75 received
[40000] (09/06 10:51:40.468):{0x22A0} 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/06 10:51:43.468):{0x23EC} [BIPP] Ping 76 sent
[40000] (09/06 10:51:43.468):{0x156C} [BIPP] Ping Response 76 received
[40000] (09/06 10:52:40.469):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:52:40.469):{0x22A0} 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/06 10:52:40.485):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:52:43.469):{0x23EC} [BIPP] Ping 77 sent
[40000] (09/06 10:52:43.469):{0x156C} [BIPP] Ping Response 77 received
[40000] (09/06 10:53:40.470):{0x22A0} 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/06 10:53:43.470):{0x23EC} [BIPP] Ping 78 sent
[40000] (09/06 10:53:43.470):{0x156C} [BIPP] Ping Response 78 received
[40000] (09/06 10:54:40.472):{0x22A0} 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/06 10:54:43.472):{0x23EC} [BIPP] Ping 79 sent
[40000] (09/06 10:54:43.472):{0x156C} [BIPP] Ping Response 79 received
[40000] (09/06 10:55:40.473):{0x22A0} 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/06 10:55:43.473):{0x23EC} [BIPP] Ping 80 sent
[40000] (09/06 10:55:43.473):{0x156C} [BIPP] Ping Response 80 received
[40000] (09/06 10:56:40.474):{0x22A0} 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/06 10:56:43.474):{0x23EC} [BIPP] Ping 81 sent
[40000] (09/06 10:56:43.474):{0x156C} [BIPP] Ping Response 81 received
[40000] (09/06 10:57:40.444):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 10:57:40.444):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 10:57:40.444):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing QUEUE_STALE_ITPOLICIES request
[40000] (09/06 10:57:40.444):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed QUEUE_STALE_ITPOLICIES request
[40000] (09/06 10:57:40.444):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:57:40.459):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30181] (09/06 10:57:40.475):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 10:57:40.475):{0x22A0} 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/06 10:57:40.475):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:57:40.491):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 10:57:43.475):{0x23EC} [BIPP] Ping 82 sent
[40000] (09/06 10:57:43.475):{0x156C} [BIPP] Ping Response 82 received
[40000] (09/06 10:58:40.476):{0x22A0} 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/06 10:58:43.476):{0x23EC} [BIPP] Ping 83 sent
[40000] (09/06 10:58:43.476):{0x156C} [BIPP] Ping Response 83 received
[40000] (09/06 10:59:40.477):{0x22A0} 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/06 10:59:43.477):{0x23EC} [BIPP] Ping 84 sent
[40000] (09/06 10:59:43.477):{0x156C} [BIPP] Ping Response 84 received
[40000] (09/06 11:00:40.478):{0x22A0} 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/06 11:00:43.478):{0x23EC} [BIPP] Ping 85 sent
[40000] (09/06 11:00:43.478):{0x156C} [BIPP] Ping Response 85 received
[40000] (09/06 11:01:40.480):{0x22A0} 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/06 11:01:43.480):{0x23EC} [BIPP] Ping 86 sent
[40000] (09/06 11:01:43.480):{0x156C} [BIPP] Ping Response 86 received
[40000] (09/06 11:02:40.481):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:02:40.481):{0x22A0} 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/06 11:02:40.496):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:02:43.481):{0x23EC} [BIPP] Ping 87 sent
[40000] (09/06 11:02:43.481):{0x156C} [BIPP] Ping Response 87 received
[40000] (09/06 11:03:40.482):{0x22A0} 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/06 11:03:43.482):{0x23EC} [BIPP] Ping 88 sent
[40000] (09/06 11:03:43.482):{0x156C} [BIPP] Ping Response 88 received
[40000] (09/06 11:04:40.483):{0x22A0} 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/06 11:04:43.483):{0x23EC} [BIPP] Ping 89 sent
[40000] (09/06 11:04:43.483):{0x156C} [BIPP] Ping Response 89 received
[40000] (09/06 11:05:40.484):{0x22A0} 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/06 11:05:43.484):{0x23EC} [BIPP] Ping 90 sent
[40000] (09/06 11:05:43.484):{0x156C} [BIPP] Ping Response 90 received
[40000] (09/06 11:06:40.485):{0x22A0} 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/06 11:06:43.485):{0x23EC} [BIPP] Ping 91 sent
[40000] (09/06 11:06:43.485):{0x156C} [BIPP] Ping Response 91 received
[40000] (09/06 11:07:40.471):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 11:07:40.471):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[30181] (09/06 11:07:40.486):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:07:40.486):{0x22A0} 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/06 11:07:40.486):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:07:40.502):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 11:07:42.658):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 11:07:42.674):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - No changes detected.
[40000] (09/06 11:07:43.487):{0x23EC} [BIPP] Ping 92 sent
[40000] (09/06 11:07:43.487):{0x156C} [BIPP] Ping Response 92 received
[40000] (09/06 11:08:40.488):{0x22A0} 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/06 11:08:43.488):{0x23EC} [BIPP] Ping 93 sent
[40000] (09/06 11:08:43.488):{0x156C} [BIPP] Ping Response 93 received
[40000] (09/06 11:09:40.489):{0x22A0} 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/06 11:09:43.489):{0x23EC} [BIPP] Ping 94 sent
[40000] (09/06 11:09:43.489):{0x156C} [BIPP] Ping Response 94 received
[40000] (09/06 11:10:40.490):{0x22A0} 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/06 11:10:43.490):{0x23EC} [BIPP] Ping 95 sent
[40000] (09/06 11:10:43.490):{0x156C} [BIPP] Ping Response 95 received
[40000] (09/06 11:11:40.491):{0x22A0} 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/06 11:11:43.491):{0x23EC} [BIPP] Ping 96 sent
[40000] (09/06 11:11:43.491):{0x156C} [BIPP] Ping Response 96 received
[40000] (09/06 11:12:40.492):{0x22A0} 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/06 11:12:40.492):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:12:40.508):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:12:43.492):{0x23EC} [BIPP] Ping 97 sent
[40000] (09/06 11:12:43.492):{0x156C} [BIPP] Ping Response 97 received
[40000] (09/06 11:13:40.493):{0x22A0} 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/06 11:13:43.493):{0x23EC} [BIPP] Ping 98 sent
[40000] (09/06 11:13:43.493):{0x156C} [BIPP] Ping Response 98 received
[40000] (09/06 11:14:40.495):{0x22A0} 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/06 11:14:43.495):{0x23EC} [BIPP] Ping 99 sent
[40000] (09/06 11:14:43.495):{0x156C} [BIPP] Ping Response 99 received
[40000] (09/06 11:15:40.496):{0x22A0} 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/06 11:15:43.496):{0x23EC} [BIPP] Ping 100 sent
[40000] (09/06 11:15:43.496):{0x156C} [BIPP] Ping Response 100 received
[40000] (09/06 11:16:40.497):{0x22A0} 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/06 11:16:43.497):{0x23EC} [BIPP] Ping 101 sent
[40000] (09/06 11:16:43.497):{0x156C} [BIPP] Ping Response 101 received
[30181] (09/06 11:17:40.498):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:17:40.498):{0x22A0} 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/06 11:17:40.498):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:17:40.514):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:17:43.498):{0x23EC} [BIPP] Ping 102 sent
[40000] (09/06 11:17:43.498):{0x156C} [BIPP] Ping Response 102 received
[40000] (09/06 11:18:40.499):{0x22A0} 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/06 11:18:43.499):{0x23EC} [BIPP] Ping 103 sent
[40000] (09/06 11:18:43.499):{0x156C} [BIPP] Ping Response 103 received
[40000] (09/06 11:19:40.500):{0x22A0} 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/06 11:19:43.500):{0x23EC} [BIPP] Ping 104 sent
[40000] (09/06 11:19:43.500):{0x156C} [BIPP] Ping Response 104 received
[40000] (09/06 11:20:40.501):{0x22A0} 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/06 11:20:43.502):{0x23EC} [BIPP] Ping 105 sent
[40000] (09/06 11:20:43.502):{0x156C} [BIPP] Ping Response 105 received
[40000] (09/06 11:21:40.503):{0x22A0} 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/06 11:21:43.503):{0x23EC} [BIPP] Ping 106 sent
[40000] (09/06 11:21:43.503):{0x156C} [BIPP] Ping Response 106 received
[40000] (09/06 11:22:40.504):{0x22A0} 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/06 11:22:40.504):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:22:40.519):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:22:43.504):{0x23EC} [BIPP] Ping 107 sent
[40000] (09/06 11:22:43.504):{0x156C} [BIPP] Ping Response 107 received
[40000] (09/06 11:23:40.505):{0x22A0} 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/06 11:23:43.505):{0x23EC} [BIPP] Ping 108 sent
[40000] (09/06 11:23:43.505):{0x156C} [BIPP] Ping Response 108 received
[40000] (09/06 11:24:40.506):{0x22A0} 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/06 11:24:43.506):{0x23EC} [BIPP] Ping 109 sent
[40000] (09/06 11:24:43.506):{0x156C} [BIPP] Ping Response 109 received
[40000] (09/06 11:25:40.507):{0x22A0} 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/06 11:25:43.507):{0x23EC} [BIPP] Ping 110 sent
[40000] (09/06 11:25:43.507):{0x156C} [BIPP] Ping Response 110 received
[40000] (09/06 11:26:40.508):{0x22A0} 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/06 11:26:43.508):{0x23EC} [BIPP] Ping 111 sent
[40000] (09/06 11:26:43.508):{0x156C} [BIPP] Ping Response 111 received
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing QUEUE_STALE_ITPOLICIES request
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed QUEUE_STALE_ITPOLICIES request
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 11:27:40.494):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[40000] (09/06 11:27:40.494):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[30181] (09/06 11:27:40.510):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:27:40.510):{0x22A0} 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/06 11:27:40.510):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[20000] (09/06 11:27:40.510):{0x1314} SCS::CheckDBforUserConfigChanges - Skip processing as a check is already in progress.
[40000] (09/06 11:27:40.510):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:27:40.510):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:27:40.510):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:27:40.525):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:27:43.510):{0x23EC} [BIPP] Ping 112 sent
[40000] (09/06 11:27:43.510):{0x156C} [BIPP] Ping Response 112 received
[40000] (09/06 11:28:40.511):{0x22A0} 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/06 11:28:43.511):{0x23EC} [BIPP] Ping 113 sent
[40000] (09/06 11:28:43.511):{0x156C} [BIPP] Ping Response 113 received
[40000] (09/06 11:29:40.512):{0x22A0} 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/06 11:29:43.512):{0x23EC} [BIPP] Ping 114 sent
[40000] (09/06 11:29:43.512):{0x156C} [BIPP] Ping Response 114 received
[40000] (09/06 11:30:40.513):{0x22A0} 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/06 11:30:43.513):{0x23EC} [BIPP] Ping 115 sent
[40000] (09/06 11:30:43.513):{0x156C} [BIPP] Ping Response 115 received
[40000] (09/06 11:31:40.514):{0x22A0} 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/06 11:31:43.514):{0x23EC} [BIPP] Ping 116 sent
[40000] (09/06 11:31:43.514):{0x156C} [BIPP] Ping Response 116 received
[40000] (09/06 11:32:40.515):{0x22A0} 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/06 11:32:40.515):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:32:40.531):{0x1B6C} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:32:43.515):{0x23EC} [BIPP] Ping 117 sent
[40000] (09/06 11:32:43.515):{0x156C} [BIPP] Ping Response 117 received
[40000] (09/06 11:33:40.516):{0x22A0} 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/06 11:33:43.516):{0x23EC} [BIPP] Ping 118 sent
[40000] (09/06 11:33:43.516):{0x156C} [BIPP] Ping Response 118 received
[40000] (09/06 11:34:40.518):{0x22A0} 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/06 11:34:43.518):{0x23EC} [BIPP] Ping 119 sent
[40000] (09/06 11:34:43.518):{0x156C} [BIPP] Ping Response 119 received
[40000] (09/06 11:35:40.519):{0x22A0} 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/06 11:35:43.519):{0x23EC} [BIPP] Ping 120 sent
[40000] (09/06 11:35:43.519):{0x156C} [BIPP] Ping Response 120 received
[40000] (09/06 11:36:40.520):{0x22A0} 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/06 11:36:43.520):{0x23EC} [BIPP] Ping 121 sent
[40000] (09/06 11:36:43.520):{0x156C} [BIPP] Ping Response 121 received
[30181] (09/06 11:37:40.521):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:37:40.521):{0x22A0} 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/06 11:37:40.521):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:37:40.537):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[30000] (09/06 11:37:42.724):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - Performing XML SB change detection
[30000] (09/06 11:37:42.740):{0x1CAC} DBChangeMonitor::CheckDatabaseForChanges - No changes detected.
[40000] (09/06 11:37:43.521):{0x23EC} [BIPP] Ping 122 sent
[40000] (09/06 11:37:43.521):{0x156C} [BIPP] Ping Response 122 received
[40000] (09/06 11:38:40.538):{0x22A0} 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/06 11:38:43.554):{0x23EC} [BIPP] Ping 123 sent
[40000] (09/06 11:38:43.554):{0x156C} [BIPP] Ping Response 123 received
[40000] (09/06 11:39:40.523):{0x22A0} 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/06 11:39:43.570):{0x23EC} [BIPP] Ping 124 sent
[40000] (09/06 11:39:43.570):{0x156C} [BIPP] Ping Response 124 received
[40000] (09/06 11:40:40.524):{0x22A0} 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/06 11:40:43.587):{0x23EC} [BIPP] Ping 125 sent
[40000] (09/06 11:40:43.587):{0x156C} [BIPP] Ping Response 125 received
[40000] (09/06 11:41:40.526):{0x22A0} 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/06 11:41:43.604):{0x23EC} [BIPP] Ping 126 sent
[40000] (09/06 11:41:43.604):{0x156C} [BIPP] Ping Response 126 received
[40000] (09/06 11:42:40.527):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:42:40.527):{0x22A0} 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/06 11:42:40.542):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:42:43.621):{0x23EC} [BIPP] Ping 127 sent
[40000] (09/06 11:42:43.621):{0x156C} [BIPP] Ping Response 127 received
[40000] (09/06 11:43:40.528):{0x22A0} 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/06 11:43:43.637):{0x23EC} [BIPP] Ping 128 sent
[40000] (09/06 11:43:43.637):{0x156C} [BIPP] Ping Response 128 received
[40000] (09/06 11:44:40.529):{0x22A0} 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/06 11:44:43.654):{0x23EC} [BIPP] Ping 129 sent
[40000] (09/06 11:44:43.654):{0x156C} [BIPP] Ping Response 129 received
[40000] (09/06 11:45:40.530):{0x22A0} 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/06 11:45:43.655):{0x23EC} [BIPP] Ping 130 sent
[40000] (09/06 11:45:43.655):{0x156C} [BIPP] Ping Response 130 received
[40000] (09/06 11:46:40.531):{0x22A0} 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/06 11:46:43.656):{0x23EC} [BIPP] Ping 131 sent
[40000] (09/06 11:46:43.656):{0x156C} [BIPP] Ping Response 131 received
[40000] (09/06 11:47:40.533):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Processing REQUEST_TIMEOUT_CHECK request
[40000] (09/06 11:47:40.533):{0x1FD0} {}RequestHandler::smileyvery-happy:oWork - Completed REQUEST_TIMEOUT_CHECK request
[40000] (09/06 11:47:40.533):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[30181] (09/06 11:47:40.533):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:47:40.548):{0x22A0} 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/06 11:47:40.548):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:47:43.658):{0x23EC} [BIPP] Ping 132 sent
[40000] (09/06 11:47:43.658):{0x156C} [BIPP] Ping Response 132 received
[40000] (09/06 11:48:40.534):{0x22A0} 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/06 11:48:43.659):{0x23EC} [BIPP] Ping 133 sent
[40000] (09/06 11:48:43.659):{0x156C} [BIPP] Ping Response 133 received
[40000] (09/06 11:49:40.535):{0x22A0} 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/06 11:49:43.660):{0x23EC} [BIPP] Ping 134 sent
[40000] (09/06 11:49:43.660):{0x156C} [BIPP] Ping Response 134 received
[40000] (09/06 11:50:40.536):{0x22A0} 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/06 11:50:43.661):{0x23EC} [BIPP] Ping 135 sent
[40000] (09/06 11:50:43.661):{0x156C} [BIPP] Ping Response 135 received
[40000] (09/06 11:51:40.537):{0x22A0} 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/06 11:51:43.662):{0x23EC} [BIPP] Ping 136 sent
[40000] (09/06 11:51:43.662):{0x156C} [BIPP] Ping Response 136 received
[40000] (09/06 11:52:40.538):{0x22A0} 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/06 11:52:40.538):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:52:40.554):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:52:43.663):{0x23EC} [BIPP] Ping 137 sent
[40000] (09/06 11:52:43.663):{0x156C} [BIPP] Ping Response 137 received
[40000] (09/06 11:53:40.539):{0x22A0} 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/06 11:53:43.665):{0x23EC} [BIPP] Ping 138 sent
[40000] (09/06 11:53:43.665):{0x156C} [BIPP] Ping Response 138 received
[40000] (09/06 11:54:40.541):{0x22A0} 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/06 11:54:43.666):{0x23EC} [BIPP] Ping 139 sent
[40000] (09/06 11:54:43.666):{0x156C} [BIPP] Ping Response 139 received
[40000] (09/06 11:55:40.542):{0x22A0} 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/06 11:55:43.667):{0x23EC} [BIPP] Ping 140 sent
[40000] (09/06 11:55:43.667):{0x156C} [BIPP] Ping Response 140 received
[40000] (09/06 11:56:40.543):{0x22A0} 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/06 11:56:43.668):{0x23EC} [BIPP] Ping 141 sent
[40000] (09/06 11:56:43.668):{0x156C} [BIPP] Ping Response 141 received
[30181] (09/06 11:57:40.544):{0x1C60} Performing system health check (BES [BlackBerryPolicyServer Version 5.0.3.13] - w8ukbes.uk.domaingroup.lan [POLC] - Exchange)
[40000] (09/06 11:57:40.544):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:57:40.544):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 11:57:40.544):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_UNAPPLIED_ITPOLICIES request
[40000] (09/06 11:57:40.544):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Processing QUEUE_STALE_ITPOLICIES request
[40000] (09/06 11:57:40.544):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[20000] (09/06 11:57:40.560):{0x5B4} SCS::CheckDBforUserConfigChanges - Skip processing as a check is already in progress.
[40000] (09/06 11:57:40.560):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:57:40.560):{0x1314} {}RequestHandler::smileyvery-happy:oWork - Completed QUEUE_STALE_ITPOLICIES request
[40000] (09/06 11:57:40.560):{0x22A0} 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/06 11:57:40.560):{0xA40} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:57:40.560):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:57:40.591):{0x5B4} {}RequestHandler::smileyvery-happy:oWork - Completed CHECK_FOR_USERCONFIG_CHANGES request
[40000] (09/06 11:57:43.669):{0x23EC} [BIPP] Ping 142 sent
[40000] (09/06 11:57:43.669):{0x156C} [BIPP] Ping Response 142 received
[40000] (09/06 11:58:40.545):{0x22A0} 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/06 11:58:43.670):{0x23EC} [BIPP] Ping 143 sent
[40000] (09/06 11:58:43.670):{0x156C} [BIPP] Ping Response 143 received
[40000] (09/06 11:59:40.546):{0x22A0} 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/06 11:59:43.671):{0x23EC} [BIPP] Ping 144 sent
[40000] (09/06 11:59:43.671):{0x156C} [BIPP] Ping Response 144 received

 

Trusted Contributor
Hape
Posts: 146
Registered: ‎08-18-2010
My Device: Z10

Re: Devices not activating

Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Re: Devices not activating

One of the possible causes of this is that in the MAGT log it says for users we are trying to activate "Handled by other server Servername"

 

Before we decomissioned the old server all the users were removed. Restarting the policy service allows some of the devices to finish activating, others we have to reset the activation password again and then activate. Again they will sit there at waiting for services until the policy service is restarted.

 

Any other thoughts.

 

david

Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Re: Devices not activating

Is anyway able to provide any more advice on this issue?

Trusted Contributor
Hape
Posts: 146
Registered: ‎08-18-2010
My Device: Z10

Re: Devices not activating

As mentioned, not sure if you already checked this BlackBerry KB

 

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

 

there is a special part describing your problem:

Subject: Activation process stops responding at "Waiting for Services"

 

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

 

BR

HaPe

Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Re: Devices not activating

Hi There,

 

I have seen that and it does seem to be releated to Cause 5. However all users were removed off the old BES a long time ago. Could there be something in RIM's system which is associating the user accounts with the old SRP?

 

David

Guru III
knottyrope
Posts: 30,777
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: Devices not activating


d8v1d wrote:

Hi There,

 

I have seen that and it does seem to be releated to Cause 5. However all users were removed off the old BES a long time ago. Could there be something in RIM's system which is associating the user accounts with the old SRP?

 

David


The device if it has an old encryption key will need to be wiped before adding to BES

 




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


Regular Contributor
d8v1d
Posts: 74
Registered: ‎03-04-2009
My Device: Not Specified

Re: Devices not activating

Thanks for your reply.

 

The BlackBerry's were wiped before readding to the new BES.