BES Logs ... What's in them? Part 12 of 20 (ROUT log)
Posted 07-07-2009 at 05:00 AM by hdawg
Tags bes log, blackberry logs, blackberry rout log, blackberry router service, blackberry server logs, rout log, router log, router service
Welcome to Part 12 of the 20 part series looking at the BES logs. (Part 11).
This will be the only time I provide you with an entire log file within a post ... because this one is just so clean.
The BlackBerry Router Service logs to the ROUT log, and under normal circumstances it should be the smallest of all of your logs that the BES generates.
Before I provide a clean log with nothing special in it, I'll provide some snips from a log with problems. The data below is from a server with WAN connectivity problems ... the office Internet connection was constantly flapping; the connection had been up and down all day until the end of the log entries where it finally re-established connectivity with RIM's NOC. The reference to 127.0.0.1 is because the BES is using the BlackBerry Router Service local to itself to connect to the NOC. The BlackBerry Router Service doesn't require an SRP for itself, but rather only the server with the Messaging Agent.
[30000] (06/01 17:33:08.194):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Disconnect relay session. IP=127.0.0.1
[30000] (06/01 17:33:08.194):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Relay connection down. Continuing in bypass mode until relay connection can be re-established.
[30000] (06/01 17:33:08.194):{0x1ECC} [DIAG] EVENT=Register_thread, THREADID=0x1ECC, THREADNAME="Unnamed"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Trying "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:14.069):{0x1ECC} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Connection to relay established.
[30000] (06/01 17:33:14.069):{0x1ECC} [DIAG] EVENT=Unregister_thread, THREADID=0x1ECC, THREADNAME="Unnamed"
[30000] (06/01 17:33:14.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Relay availability detected. Resetting BES connection to force connection re-authentication.
[30000] (06/01 17:33:14.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Disconnect session. IP=127.0.0.1
[30000] (06/01 17:33:14.069):{0xA20} [SERVICE_MANAGER] Connection established. Session=0x00c88e68
[30000] (06/01 17:33:14.069):{0xA20} [SERVICE_RELAY_SESSION:UNKNOWN:00c88e68] Accept service session. IP=127.0.0.1, ServiceSession=0x00bdde18
[30000] (06/01 17:33:14.069):{0x344} [DIAG] EVENT=Register_thread, THREADID=0x344, THREADNAME="SRPReceiverHandler"
[30000] (06/01 17:33:15.069):{0x1678} [DIAG] EVENT=Unregister_thread, THREADID=0x1678, THREADNAME="SRPReceiverHandler"
[30000] (06/01 17:33:15.069):{0x470} [SERVICE_MANAGER] Delete session. UID=S99999999, Session=0x00c1a680
[30000] (06/01 17:33:15.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Service claim UID. UID: S99999999 Requested SRP Version:2, IP=127.0.0.1
[30000] (06/01 17:33:15.069):{0xCA0} [DIAG] EVENT=Register_thread, THREADID=0xCA0, THREADNAME="Unnamed"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Trying "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:16.084):{0xCA0} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Connection to relay established.
[30000] (06/01 17:33:16.084):{0xCA0} [DIAG] EVENT=Unregister_thread, THREADID=0xCA0, THREADNAME="Unnamed"
[30000] (06/01 17:33:19.334):{0x470} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Service relay connection authenticated. SRPVersion: 2
[30000] (06/01 17:33:19.334):{0x470} [SERVICE_MANAGER] Session authenticated. UID=S99999999, Session=0x00c88e68
The log data below contains the ROUT log from a BES for the entire day. You'll notice the lack of entries in this log ... The server was up and running and a server restart was initiated at 7:16 AM local server time.
UTF-8 encoded
[30000] (06/01 00:00:00.082):{0xD10} Current Date: 2009/06/01
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD10, THREADNAME="DebugLogger"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD7C, THREADNAME="SRPListenerImp"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD80, THREADNAME="SRPListenerImp"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD84, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD88, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD8C, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD90, THREADNAME="TimerThread"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD94, THREADNAME="RouterEngine"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xEE8, THREADNAME="SRPReceiverHandler"
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process logged on as: DOMAIN\besadmin, Start Time: Jun 09 2009 17:07:49, Uptime (seconds): 197531
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process id: 3300
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Computer Host Name: TESTBES1 OS Version: 5.2, Build number 3790, ServicePack Major 2, ServicePack Minor 0
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Identifier: x86 Family 6 Model 23 Stepping 6
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Vendor Identifier: GenuineIntel
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Name String: Intel(R) Xeon(R) CPU E5430 @ 2.66GHz
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Number of Processors: 1
[30000] (06/01 00:00:00.082):{0xD10} [ENV] 39 percent of memory in use.
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total size of physical memory: 1572328 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of physical memory available: 953212 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of the committed memory limit: 3522024 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of available memory to commit: 2482508 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total size of the user mode portion of the virtual address space of the BES process: 2097024 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of unreserved and uncommitted memory in the user mode portion of the virtual address space of the BES process: 2065744 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total HD bytes: 21459722240, Total free bytes = 4565184512
[30000] (06/01 00:00:00.192):{0xD10} [ENV] System up time: 2 days 06 hrs 52 mins 54 secs
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Local Time Zone: Central Daylight Time (GMT-06:00)
[30000] (06/01 00:00:00.192):{0xD10} [ENV] TCP/IP provider (Winsock) File Version: 5.2.3790.0 (C:\WINDOWS\System32\wsock32.dll)
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Local machine IP Address = 192.168.1.201
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Winsock2 file: Network Location Awareness (NLA) Namespace, Version: 5.2.3790.4318 (C:\WINDOWS\System32\mswsock.dll)
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Microsoft XML Parser 6.0: C:\WINDOWS\system32\msxml6.dll, Version: 6.20.1099.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] MDAC version: 2.82.3959.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] MSADO15.DLL: C:\Program Files\Common Files\System\ado\msado15.dll, Version: 2.82.3959.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: System
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: smss.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: csrss.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: winlogon.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: services.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: lsass.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: spoolsv.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: msdtc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: vmsrvc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBAttachServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: bmds.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BESAlert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: DWRCS.EXE
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: inetinfo.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: snmp.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: Wuser32.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryController.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackberryRouter.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: CcmExec.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: exmgmt.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mad.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mssearch.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: store.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: emsmta.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: ITAdminServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerrySyncServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: DWRCST.EXE
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: explorer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: vmusrvc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: jusched.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: ctfmon.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: bbmgrw32.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: RIMDeviceManager.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BbDevMgr.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: jucheck.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mmc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mmc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryDispatcher.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryAgent.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: logon.scr
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerryBypassRouter Version 4.1.5.24
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BES Service Name: BlackBerry Router
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry Dispatcher: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryDispatcher.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry User Administration Service: NOT FOUND
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry Attachment Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\AttachServer\BBAttachServer.exe, Version: 4.1.5.14
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry MDS Connection Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\bmds.exe, Version: 4.1.5.26
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Database Consistency Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\DBConsistency.exe, Version: 4.1.5.40
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Policy Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\ITAdminServer.exe, Version: 4.1.5.29
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Synchronization Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\SyncServer\BlackBerrySyncServer.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Router: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Controller: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryController.exe, Version: 4.1.5.40
[30000] (06/01 00:00:00.372):{0xD94} [ENV] BlackBerry Alert: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BESAlert.exe, Version: 4.1.5.19
[30000] (06/01 07:16:20.284):{0xD90} [DIAG] EVENT=Unregister_thread, THREADID=0xD90, THREADNAME="TimerThread"
[30000] (06/01 07:16:20.314):{0xD1C} [ENGINE] Stopping
[30000] (06/01 07:16:20.324):{0xD94} [ENGINE] RouterEngine thread stop signalled.
[30000] (06/01 07:16:20.324):{0xD94} [DIAG] EVENT=Unregister_thread, THREADID=0xD94, THREADNAME="RouterEngine"
[30000] (06/01 07:16:20.334):{0xD1C} [SERVICE_MANAGER] Stopping
[30000] (06/01 07:16:20.334):{0xD7C} [DIAG] EVENT=Unregister_thread, THREADID=0xD7C, THREADNAME="SRPListenerImp"
[30000] (06/01 07:16:20.334):{0xD1C} [SERVICE_RELAY_SESSION:S99999999:00b7ce98] Disconnect session. IP=127.0.0.1
[30000] (06/01 07:16:21.335):{0xEE8} [DIAG] EVENT=Unregister_thread, THREADID=0xEE8, THREADNAME="SRPReceiverHandler"
[30000] (06/01 07:16:21.335):{0xD1C} [SERVICE_MANAGER] Delete session. UID=S99999999, Session=0x00b7ce98
[30000] (06/01 07:16:21.335):{0xD1C} [SERVICE_MANAGER] Destroyed
[30000] (06/01 07:16:21.335):{0xD1C} [MANAGER_DEVICE] Stopping
[30000] (06/01 07:16:21.335):{0xD80} [DIAG] EVENT=Unregister_thread, THREADID=0xD80, THREADNAME="SRPListenerImp"
[30000] (06/01 07:16:21.335):{0xD1C} [DEVICE_MANAGER] Destroyed
[30000] (06/01 07:16:21.335):{0xD1C} [ENGINE] Stopping
[50101] (06/01 07:16:21.335):{0xD1C} BlackBerry Router Shutdown complete
[30000] (06/01 07:17:55.692):{0xD00} Current Date: 2009/06/01
[30000] (06/01 07:17:55.702):{0xD00} [DIAG] EVENT=Thread_report, THREADID=0xD00, THREADNAME="DebugLogger"
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process logged on as: DOMAIN\besadmin, Start Time: Jun 12 2009 07:17:55, Uptime (seconds): 0
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process id: 3292
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Computer Host Name: TESTBES1, OS Version: 5.2, Build number 3790, ServicePack Major 2, ServicePack Minor 0
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Identifier: x86 Family 6 Model 23 Stepping 6
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Vendor Identifier: GenuineIntel
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Name String: Intel(R) Xeon(R) CPU E5430 @ 2.66GHz
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Number of Processors: 1
[30000] (06/01 07:17:55.702):{0xD00} [ENV] 21 percent of memory in use.
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total size of physical memory: 1572328 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of physical memory available: 1237576 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of the committed memory limit: 3522024 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of available memory to commit: 3247520 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total size of the user mode portion of the virtual address space of the BES process: 2097024 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of unreserved and uncommitted memory in the user mode portion of the virtual address space of the BES process: 2077224 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total HD bytes: 21459722240, Total free bytes = 4564434944
[30000] (06/01 07:17:55.742):{0xD00} [ENV] System up time: 0 days 00 hrs 00 mins 43 secs
[30000] (06/01 07:17:55.742):{0xD00} [ENV] Local Time Zone: Central Daylight Time (GMT-06:00)
[30000] (06/01 07:17:55.742):{0xD00} [ENV] TCP/IP provider (Winsock) File Version: 5.2.3790.0 (C:\WINDOWS\System32\wsock32.dll)
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Local machine IP Address = 192.168.1.201
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Winsock2 file: Network Location Awareness (NLA) Namespace, Version: 5.2.3790.4318 (C:\WINDOWS\System32\mswsock.dll)
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Microsoft XML Parser 6.0: C:\WINDOWS\system32\msxml6.dll, Version: 6.20.1099.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] MDAC version: 2.82.3959.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] MSADO15.DLL: C:\Program Files\Common Files\System\ado\msado15.dll, Version: 2.82.3959.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: System
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: smss.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: csrss.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: winlogon.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: services.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: lsass.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: spoolsv.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: msdtc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: vmsrvc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBAttachServer.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: bmds.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BESAlert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: DWRCS.EXE
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: inetinfo.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: snmp.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: smlogsvc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: vpcmap.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: Wuser32.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BlackBerryController.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BlackberryRouter.exe
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerryBypassRouter Version 4.1.5.24
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BES Service Name: BlackBerry Router
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerry Dispatcher: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryDispatcher.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerry User Administration Service: NOT FOUND
[30000] (06/01 07:17:55.792):{0xCE0} [ENV] BlackBerry Attachment Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\AttachServer\BBAttachServer.exe, Version: 4.1.5.14
[30000] (06/01 07:17:55.792):{0xCE0} [ENV] BlackBerry MDS Connection Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\bmds.exe, Version: 4.1.5.26
[30000] (06/01 07:17:55.802):{0xCE0} [ENV] BlackBerry Database Consistency Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\DBConsistency.exe, Version: 4.1.5.40
[30000] (06/01 07:17:55.802):{0xCE0} [ENV] BlackBerry Policy Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\ITAdminServer.exe, Version: 4.1.5.29
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Synchronization Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\SyncServer\BlackBerrySyncServer.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Router: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Controller: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryController.exe, Version: 4.1.5.40
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Alert: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BESAlert.exe, Version: 4.1.5.19
[30000] (06/01 07:17:55.812):{0xCE0} [MAIN] Copyright 1997-2008 Research In Motion Limited
[30000] (06/01 07:17:55.812):{0xCE0} [MAIN] Modification date: Apr 4 2008
[30000] (06/01 07:17:55.922):{0xD1C} [ENGINE] Starting
[30000] (06/01 07:17:55.952):{0xD1C} [CONFIGURATION] EVENT=Adding BBR hostname h_name: testbes1.port3101.org
[30000] (06/01 07:17:55.952):{0xD1C} [SERVICE_MANAGER] Created
[30000] (06/01 07:17:55.952):{0xD1C} [SERVICE_MANAGER] Starting
[30000] (06/01 07:17:55.952):{0xD1C} [DEVICE_MANAGER] Created
[30000] (06/01 07:17:55.952):{0xD1C} [DEVICE_MANAGER] Starting
[50100] (06/01 07:17:55.962):{0xD1C} BlackBerry Router started
[30000] (06/01 07:17:56.002):{0xD68} [DIAG] EVENT=Register_thread, THREADID=0xD68, THREADNAME="SRPListenerImp"
[30000] (06/01 07:17:56.002):{0xD6C} [DIAG] EVENT=Register_thread, THREADID=0xD6C, THREADNAME="SRPListenerImp"
[30000] (06/01 07:17:56.002):{0xD70} [DIAG] EVENT=Register_thread, THREADID=0xD70, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD74} [DIAG] EVENT=Register_thread, THREADID=0xD74, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD78} [DIAG] EVENT=Register_thread, THREADID=0xD78, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD7C} [DIAG] EVENT=Register_thread, THREADID=0xD7C, THREADNAME="TimerThread"
[30000] (06/01 07:17:56.002):{0xD80} [DIAG] EVENT=Register_thread, THREADID=0xD80, THREADNAME="RouterEngine"
[30000] (06/01 07:18:08.340):{0xD68} [SERVICE_MANAGER] Connection established. Session=0x00b53460
[30000] (06/01 07:18:08.340):{0xD68} [SERVICE_RELAY_SESSION:UNKNOWN:00b53460] Accept service session. IP=127.0.0.1, ServiceSession=0x00b56c20
[30000] (06/01 07:18:08.430):{0x1300} [DIAG] EVENT=Register_thread, THREADID=0x1300, THREADNAME="SRPReceiverHandler"
[30000] (06/01 07:18:09.892):{0xD80} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Service claim UID. UID: S99999999 Requested SRP Version:2, IP=127.0.0.1
[30000] (06/01 07:18:10.012):{0x14F8} [DIAG] EVENT=Register_thread, THREADID=0x14F8, THREADNAME="Unnamed"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Trying "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 07:18:10.122):{0x14F8} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Connection to relay established.
[30000] (06/01 07:18:10.122):{0x14F8} [DIAG] EVENT=Unregister_thread, THREADID=0x14F8, THREADNAME="Unnamed"
[30000] (06/01 07:18:10.283):{0xD80} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Service relay connection authenticated. SRPVersion: 2
[30000] (06/01 07:18:10.283):{0xD80} [SERVICE_MANAGER] Session authenticated. UID=S99999999, Session=0x00b52ab0
_____________________
That's it for today. If you've got any questions about other specific entries in the ROUT log feel free to post a question / comment in response to this post, or in the forum.
Tomorrow, in Part 13, we'll tackle the BlackBerry Synchronization Service (SYNC) log.
This will be the only time I provide you with an entire log file within a post ... because this one is just so clean.
The BlackBerry Router Service logs to the ROUT log, and under normal circumstances it should be the smallest of all of your logs that the BES generates.
Before I provide a clean log with nothing special in it, I'll provide some snips from a log with problems. The data below is from a server with WAN connectivity problems ... the office Internet connection was constantly flapping; the connection had been up and down all day until the end of the log entries where it finally re-established connectivity with RIM's NOC. The reference to 127.0.0.1 is because the BES is using the BlackBerry Router Service local to itself to connect to the NOC. The BlackBerry Router Service doesn't require an SRP for itself, but rather only the server with the Messaging Agent.
[30000] (06/01 17:33:08.194):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Disconnect relay session. IP=127.0.0.1
[30000] (06/01 17:33:08.194):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Relay connection down. Continuing in bypass mode until relay connection can be re-established.
[30000] (06/01 17:33:08.194):{0x1ECC} [DIAG] EVENT=Register_thread, THREADID=0x1ECC, THREADNAME="Unnamed"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 17:33:13.194):{0x1ECC} [RELAY_SRP:S99999999:00b6d420] Connect: Trying "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:14.069):{0x1ECC} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Connection to relay established.
[30000] (06/01 17:33:14.069):{0x1ECC} [DIAG] EVENT=Unregister_thread, THREADID=0x1ECC, THREADNAME="Unnamed"
[30000] (06/01 17:33:14.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Relay availability detected. Resetting BES connection to force connection re-authentication.
[30000] (06/01 17:33:14.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00b1a310] Disconnect session. IP=127.0.0.1
[30000] (06/01 17:33:14.069):{0xA20} [SERVICE_MANAGER] Connection established. Session=0x00c88e68
[30000] (06/01 17:33:14.069):{0xA20} [SERVICE_RELAY_SESSION:UNKNOWN:00c88e68] Accept service session. IP=127.0.0.1, ServiceSession=0x00bdde18
[30000] (06/01 17:33:14.069):{0x344} [DIAG] EVENT=Register_thread, THREADID=0x344, THREADNAME="SRPReceiverHandler"
[30000] (06/01 17:33:15.069):{0x1678} [DIAG] EVENT=Unregister_thread, THREADID=0x1678, THREADNAME="SRPReceiverHandler"
[30000] (06/01 17:33:15.069):{0x470} [SERVICE_MANAGER] Delete session. UID=S99999999, Session=0x00c1a680
[30000] (06/01 17:33:15.069):{0x470} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Service claim UID. UID: S99999999 Requested SRP Version:2, IP=127.0.0.1
[30000] (06/01 17:33:15.069):{0xCA0} [DIAG] EVENT=Register_thread, THREADID=0xCA0, THREADNAME="Unnamed"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 17:33:15.069):{0xCA0} [RELAY_SRP:UNKNOWN:003efd68] Connect: Trying "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 17:33:16.084):{0xCA0} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Connection to relay established.
[30000] (06/01 17:33:16.084):{0xCA0} [DIAG] EVENT=Unregister_thread, THREADID=0xCA0, THREADNAME="Unnamed"
[30000] (06/01 17:33:19.334):{0x470} [SERVICE_RELAY_SESSION:S99999999:00d2a514] Service relay connection authenticated. SRPVersion: 2
[30000] (06/01 17:33:19.334):{0x470} [SERVICE_MANAGER] Session authenticated. UID=S99999999, Session=0x00c88e68
The log data below contains the ROUT log from a BES for the entire day. You'll notice the lack of entries in this log ... The server was up and running and a server restart was initiated at 7:16 AM local server time.
UTF-8 encoded
[30000] (06/01 00:00:00.082):{0xD10} Current Date: 2009/06/01
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD10, THREADNAME="DebugLogger"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD7C, THREADNAME="SRPListenerImp"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD80, THREADNAME="SRPListenerImp"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD84, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD88, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD8C, THREADNAME="Unnamed"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD90, THREADNAME="TimerThread"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xD94, THREADNAME="RouterEngine"
[30000] (06/01 00:00:00.082):{0xD10} [DIAG] EVENT=Thread_report, THREADID=0xEE8, THREADNAME="SRPReceiverHandler"
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process logged on as: DOMAIN\besadmin, Start Time: Jun 09 2009 17:07:49, Uptime (seconds): 197531
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Current Process id: 3300
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Computer Host Name: TESTBES1 OS Version: 5.2, Build number 3790, ServicePack Major 2, ServicePack Minor 0
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Identifier: x86 Family 6 Model 23 Stepping 6
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Vendor Identifier: GenuineIntel
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Processor Name String: Intel(R) Xeon(R) CPU E5430 @ 2.66GHz
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Number of Processors: 1
[30000] (06/01 00:00:00.082):{0xD10} [ENV] 39 percent of memory in use.
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total size of physical memory: 1572328 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of physical memory available: 953212 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of the committed memory limit: 3522024 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of available memory to commit: 2482508 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total size of the user mode portion of the virtual address space of the BES process: 2097024 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Size of unreserved and uncommitted memory in the user mode portion of the virtual address space of the BES process: 2065744 KB
[30000] (06/01 00:00:00.082):{0xD10} [ENV] Total HD bytes: 21459722240, Total free bytes = 4565184512
[30000] (06/01 00:00:00.192):{0xD10} [ENV] System up time: 2 days 06 hrs 52 mins 54 secs
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Local Time Zone: Central Daylight Time (GMT-06:00)
[30000] (06/01 00:00:00.192):{0xD10} [ENV] TCP/IP provider (Winsock) File Version: 5.2.3790.0 (C:\WINDOWS\System32\wsock32.dll)
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Local machine IP Address = 192.168.1.201
[30000] (06/01 00:00:00.192):{0xD10} [ENV] Winsock2 file: Network Location Awareness (NLA) Namespace, Version: 5.2.3790.4318 (C:\WINDOWS\System32\mswsock.dll)
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Microsoft XML Parser 6.0: C:\WINDOWS\system32\msxml6.dll, Version: 6.20.1099.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] MDAC version: 2.82.3959.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] MSADO15.DLL: C:\Program Files\Common Files\System\ado\msado15.dll, Version: 2.82.3959.0
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: System
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: smss.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: csrss.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: winlogon.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: services.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: lsass.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: spoolsv.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: msdtc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: vmsrvc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBAttachServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: bmds.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BESAlert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: DWRCS.EXE
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: inetinfo.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: snmp.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: Wuser32.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryController.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackberryRouter.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: CcmExec.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: exmgmt.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mad.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mssearch.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: store.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: emsmta.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: ITAdminServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerrySyncServer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: wmiprvse.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: DWRCST.EXE
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: explorer.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: vmusrvc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: jusched.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: ctfmon.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: bbmgrw32.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: RIMDeviceManager.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BbDevMgr.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: jucheck.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: svchost.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mmc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: mmc.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryDispatcher.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BlackBerryAgent.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: logon.scr
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD10} [ENV] Running Process: BBConvert.exe
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerryBypassRouter Version 4.1.5.24
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BES Service Name: BlackBerry Router
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry Dispatcher: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryDispatcher.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry User Administration Service: NOT FOUND
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry Attachment Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\AttachServer\BBAttachServer.exe, Version: 4.1.5.14
[30000] (06/01 00:00:00.202):{0xD94} [ENV] BlackBerry MDS Connection Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\bmds.exe, Version: 4.1.5.26
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Database Consistency Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\DBConsistency.exe, Version: 4.1.5.40
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Policy Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\ITAdminServer.exe, Version: 4.1.5.29
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Synchronization Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\SyncServer\BlackBerrySyncServer.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Router: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe, Version: 4.1.5.24
[30000] (06/01 00:00:00.262):{0xD94} [ENV] BlackBerry Controller: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryController.exe, Version: 4.1.5.40
[30000] (06/01 00:00:00.372):{0xD94} [ENV] BlackBerry Alert: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BESAlert.exe, Version: 4.1.5.19
[30000] (06/01 07:16:20.284):{0xD90} [DIAG] EVENT=Unregister_thread, THREADID=0xD90, THREADNAME="TimerThread"
[30000] (06/01 07:16:20.314):{0xD1C} [ENGINE] Stopping
[30000] (06/01 07:16:20.324):{0xD94} [ENGINE] RouterEngine thread stop signalled.
[30000] (06/01 07:16:20.324):{0xD94} [DIAG] EVENT=Unregister_thread, THREADID=0xD94, THREADNAME="RouterEngine"
[30000] (06/01 07:16:20.334):{0xD1C} [SERVICE_MANAGER] Stopping
[30000] (06/01 07:16:20.334):{0xD7C} [DIAG] EVENT=Unregister_thread, THREADID=0xD7C, THREADNAME="SRPListenerImp"
[30000] (06/01 07:16:20.334):{0xD1C} [SERVICE_RELAY_SESSION:S99999999:00b7ce98] Disconnect session. IP=127.0.0.1
[30000] (06/01 07:16:21.335):{0xEE8} [DIAG] EVENT=Unregister_thread, THREADID=0xEE8, THREADNAME="SRPReceiverHandler"
[30000] (06/01 07:16:21.335):{0xD1C} [SERVICE_MANAGER] Delete session. UID=S99999999, Session=0x00b7ce98
[30000] (06/01 07:16:21.335):{0xD1C} [SERVICE_MANAGER] Destroyed
[30000] (06/01 07:16:21.335):{0xD1C} [MANAGER_DEVICE] Stopping
[30000] (06/01 07:16:21.335):{0xD80} [DIAG] EVENT=Unregister_thread, THREADID=0xD80, THREADNAME="SRPListenerImp"
[30000] (06/01 07:16:21.335):{0xD1C} [DEVICE_MANAGER] Destroyed
[30000] (06/01 07:16:21.335):{0xD1C} [ENGINE] Stopping
[50101] (06/01 07:16:21.335):{0xD1C} BlackBerry Router Shutdown complete
[30000] (06/01 07:17:55.692):{0xD00} Current Date: 2009/06/01
[30000] (06/01 07:17:55.702):{0xD00} [DIAG] EVENT=Thread_report, THREADID=0xD00, THREADNAME="DebugLogger"
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process logged on as: DOMAIN\besadmin, Start Time: Jun 12 2009 07:17:55, Uptime (seconds): 0
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Current Process id: 3292
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Computer Host Name: TESTBES1, OS Version: 5.2, Build number 3790, ServicePack Major 2, ServicePack Minor 0
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Identifier: x86 Family 6 Model 23 Stepping 6
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Vendor Identifier: GenuineIntel
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Processor Name String: Intel(R) Xeon(R) CPU E5430 @ 2.66GHz
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Number of Processors: 1
[30000] (06/01 07:17:55.702):{0xD00} [ENV] 21 percent of memory in use.
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total size of physical memory: 1572328 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of physical memory available: 1237576 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of the committed memory limit: 3522024 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of available memory to commit: 3247520 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total size of the user mode portion of the virtual address space of the BES process: 2097024 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Size of unreserved and uncommitted memory in the user mode portion of the virtual address space of the BES process: 2077224 KB
[30000] (06/01 07:17:55.702):{0xD00} [ENV] Total HD bytes: 21459722240, Total free bytes = 4564434944
[30000] (06/01 07:17:55.742):{0xD00} [ENV] System up time: 0 days 00 hrs 00 mins 43 secs
[30000] (06/01 07:17:55.742):{0xD00} [ENV] Local Time Zone: Central Daylight Time (GMT-06:00)
[30000] (06/01 07:17:55.742):{0xD00} [ENV] TCP/IP provider (Winsock) File Version: 5.2.3790.0 (C:\WINDOWS\System32\wsock32.dll)
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Local machine IP Address = 192.168.1.201
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Winsock2 file: Network Location Awareness (NLA) Namespace, Version: 5.2.3790.4318 (C:\WINDOWS\System32\mswsock.dll)
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Microsoft XML Parser 6.0: C:\WINDOWS\system32\msxml6.dll, Version: 6.20.1099.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] MDAC version: 2.82.3959.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] MSADO15.DLL: C:\Program Files\Common Files\System\ado\msado15.dll, Version: 2.82.3959.0
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: System
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: smss.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: csrss.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: winlogon.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: services.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: lsass.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: spoolsv.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: msdtc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: vmsrvc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBAttachServer.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BBConvert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: bmds.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BESAlert.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: DWRCS.EXE
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: inetinfo.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: svchost.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: snmp.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: smlogsvc.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: vpcmap.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: Wuser32.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BlackBerryController.exe
[30000] (06/01 07:17:55.752):{0xD00} [ENV] Running Process: BlackberryRouter.exe
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerryBypassRouter Version 4.1.5.24
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BES Service Name: BlackBerry Router
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerry Dispatcher: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryDispatcher.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.782):{0xCE0} [ENV] BlackBerry User Administration Service: NOT FOUND
[30000] (06/01 07:17:55.792):{0xCE0} [ENV] BlackBerry Attachment Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\AttachServer\BBAttachServer.exe, Version: 4.1.5.14
[30000] (06/01 07:17:55.792):{0xCE0} [ENV] BlackBerry MDS Connection Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\bmds.exe, Version: 4.1.5.26
[30000] (06/01 07:17:55.802):{0xCE0} [ENV] BlackBerry Database Consistency Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\MDS\bin\DBConsistency.exe, Version: 4.1.5.40
[30000] (06/01 07:17:55.802):{0xCE0} [ENV] BlackBerry Policy Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\ITAdminServer.exe, Version: 4.1.5.29
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Synchronization Service: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\SyncServer\BlackBerrySyncServer.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Router: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BypassRouter\BlackberryRouter.exe, Version: 4.1.5.24
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Controller: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BlackBerryController.exe, Version: 4.1.5.40
[30000] (06/01 07:17:55.812):{0xCE0} [ENV] BlackBerry Alert: C:\Program Files\Research In Motion\BlackBerry Enterprise Server\BESAlert.exe, Version: 4.1.5.19
[30000] (06/01 07:17:55.812):{0xCE0} [MAIN] Copyright 1997-2008 Research In Motion Limited
[30000] (06/01 07:17:55.812):{0xCE0} [MAIN] Modification date: Apr 4 2008
[30000] (06/01 07:17:55.922):{0xD1C} [ENGINE] Starting
[30000] (06/01 07:17:55.952):{0xD1C} [CONFIGURATION] EVENT=Adding BBR hostname h_name: testbes1.port3101.org
[30000] (06/01 07:17:55.952):{0xD1C} [SERVICE_MANAGER] Created
[30000] (06/01 07:17:55.952):{0xD1C} [SERVICE_MANAGER] Starting
[30000] (06/01 07:17:55.952):{0xD1C} [DEVICE_MANAGER] Created
[30000] (06/01 07:17:55.952):{0xD1C} [DEVICE_MANAGER] Starting
[50100] (06/01 07:17:55.962):{0xD1C} BlackBerry Router started
[30000] (06/01 07:17:56.002):{0xD68} [DIAG] EVENT=Register_thread, THREADID=0xD68, THREADNAME="SRPListenerImp"
[30000] (06/01 07:17:56.002):{0xD6C} [DIAG] EVENT=Register_thread, THREADID=0xD6C, THREADNAME="SRPListenerImp"
[30000] (06/01 07:17:56.002):{0xD70} [DIAG] EVENT=Register_thread, THREADID=0xD70, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD74} [DIAG] EVENT=Register_thread, THREADID=0xD74, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD78} [DIAG] EVENT=Register_thread, THREADID=0xD78, THREADNAME="Unnamed"
[30000] (06/01 07:17:56.002):{0xD7C} [DIAG] EVENT=Register_thread, THREADID=0xD7C, THREADNAME="TimerThread"
[30000] (06/01 07:17:56.002):{0xD80} [DIAG] EVENT=Register_thread, THREADID=0xD80, THREADNAME="RouterEngine"
[30000] (06/01 07:18:08.340):{0xD68} [SERVICE_MANAGER] Connection established. Session=0x00b53460
[30000] (06/01 07:18:08.340):{0xD68} [SERVICE_RELAY_SESSION:UNKNOWN:00b53460] Accept service session. IP=127.0.0.1, ServiceSession=0x00b56c20
[30000] (06/01 07:18:08.430):{0x1300} [DIAG] EVENT=Register_thread, THREADID=0x1300, THREADNAME="SRPReceiverHandler"
[30000] (06/01 07:18:09.892):{0xD80} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Service claim UID. UID: S99999999 Requested SRP Version:2, IP=127.0.0.1
[30000] (06/01 07:18:10.012):{0x14F8} [DIAG] EVENT=Register_thread, THREADID=0x14F8, THREADNAME="Unnamed"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connecting to relay at address "srp.us.blackberry.net"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Found 2 addresses for host "srp.us.blackberry.net"
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Host "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Host "srp.us.blackberry.net" @ [204.187.87.33]
[30000] (06/01 07:18:10.012):{0x14F8} [RELAY_SRP:UNKNOWN:00b55eb8] Connect: Trying "srp.us.blackberry.net" @ [206.51.26.33]
[30000] (06/01 07:18:10.122):{0x14F8} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Connection to relay established.
[30000] (06/01 07:18:10.122):{0x14F8} [DIAG] EVENT=Unregister_thread, THREADID=0x14F8, THREADNAME="Unnamed"
[30000] (06/01 07:18:10.283):{0xD80} [SERVICE_RELAY_SESSION:S99999999:00b52ab0] Service relay connection authenticated. SRPVersion: 2
[30000] (06/01 07:18:10.283):{0xD80} [SERVICE_MANAGER] Session authenticated. UID=S99999999, Session=0x00b52ab0
_____________________
That's it for today. If you've got any questions about other specific entries in the ROUT log feel free to post a question / comment in response to this post, or in the forum.
Tomorrow, in Part 13, we'll tackle the BlackBerry Synchronization Service (SYNC) log.
Total Comments 0
