Backup Exec Services failing at Boot Up

[Ben_Hayes]

Server is Windows 2003 Small Buisness Server running Symantec Backup Exec 10d version 10.1 Rev. 5629 with Service Pack 2 and Hot Fix 43.

When the server is restarted, the "Backup Exec Server" service and "Backup Exec Job Engine" service fails to start automatically. Once the server is up, I can manually start each of these services.

System Event Log reports:

Event ID 7009: Timeout (30000 milliseconds) waiting for the Backup Exec Server service to connect.

Event ID 7000: The Backup Exec Server service failed to start due to the following error:
The service did not respond to the start or control request in a timely fashion.

Event ID 7001: The Backup Exec Job Engine service depends on the Backup Exec Server service which failed to start because of the following error:
The service did not respond to the start or control request in a timely fashion.

I've tried repairing the installation by running setup again, but the problem persists.

Any help resolving this issue is appreciated.

[Sharvari_Deshmu]

Hello,

Before trying to start the server service please run the sgmon utility and paste the error part in the forum to further troubleshoot the issue.

How to use the SGMON utility to perform a live debug of Backup Exec
--------------------------------------------------------------------------------

http://support.veritas.com/docs/190979


Thanks,

[Ben_Hayes]

I'm not sure if this is what you're looking for, but here is the log of sgmon which was started after a server reboot where the Backup Exec Engine failed to start automatically. I don't see any settings to filter for the "error" part or if there is a way for sgmon to run as a service and capture what you're looking for at startup.

Capturing to C:\Program Files\VERITAS\Backup Exec\NT\logs\SGMon.log
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {26DE80E5-11C1-4891-B020-5E74E5D736E2} : not scheduled to execute yet.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {D9E8BDD8-4FAF-42A6-A084-D21D06CF82B1}
Track-It! : Track-It! Audit Monitor Plugin : Loaded
Track-It! : Track-It! Audit Monitor Plugin : Executing
Track-It! : Track-It! Audit Monitor Plugin : Execute Result 0
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Audit Monitor Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {6A231542-849D-419D-9546-583D2B6291DD}
Track-It! : Track-It! Software License Management Plugin : Loaded
Track-It! : Track-It! Software License Management Plugin : Executing
Track-It! : Track-It! Software License Management Plugin : Execute Result 1
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Software License Management Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Peeked Message (15268572)
Track-It! : (null) : Peeked Message (21560028)
Track-It! : (null) : Peeked Message (17365724)
Track-It! : (null) : Message NOT Dispatched (15268572)
Track-It! : (null) : Peeked Message (20511452)
Track-It! : (null) : Peeked Message (16317148)
Track-It! : (null) : Peeked Message (19462876)
Track-It! : (null) : Peeked Message (22608604)
Track-It! : (null) : Peeked Message (13171420)
Track-It! : (null) : Peeked Message (14219996)
Track-It! : (null) : Message NOT Dispatched (21560028)
Track-It! : (null) : Message NOT Dispatched (17365724)
Track-It! : (null) : Waiting : 26297
Track-It! : (null) : Message NOT Dispatched (20511452)
Track-It! : (null) : Message NOT Dispatched (16317148)
Track-It! : (null) : Message NOT Dispatched (19462876)
Track-It! : (null) : Message NOT Dispatched (22608604)
Track-It! : (null) : Message NOT Dispatched (13171420)
Track-It! : (null) : Message NOT Dispatched (14219996)
Track-It! : (null) : Waiting : 30437
Track-It! : (null) : Waiting : 9172
Track-It! : (null) : Waiting : 1859
Track-It! : (null) : Waiting : 46703
Track-It! : (null) : Waiting : 9016
Track-It! : (null) : Waiting : 4969
Track-It! : (null) : Waiting : 19031
Track-It! : (null) : Waiting : 6328
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {D64B2D68-8A18-41C0-8236-E71CA940FAA3}
Track-It! : Track-It! Work Order Monitor Plugin : Loaded
Track-It! : Track-It! Work Order Monitor Plugin : Executing
Track-It! : Track-It! Work Order Monitor Plugin : Execute Result 52
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Work Order Monitor Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {E58E22ED-C85F-4953-9FCC-A725D6C5D535} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {23765589-D75B-41E5-8DD2-EC160695F2EF} : not scheduled to execute yet.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : (null) : Done Waiting 60000
Track-It! : {946E254C-93C6-493E-9C43-B52EF88ED705} : not enabled.
Track-It! : {7BBF76B1-464C-4C2C-A5B4-DBBD96E54B84} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {1AF8CF82-9FB4-42D5-AC40-0D046B956C09} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {26DE80E5-11C1-4891-B020-5E74E5D736E2} : not scheduled to execute yet.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {D9E8BDD8-4FAF-42A6-A084-D21D06CF82B1}
Track-It! : Track-It! Audit Monitor Plugin : Loaded
Track-It! : Track-It! Audit Monitor Plugin : Executing
Track-It! : Track-It! Audit Monitor Plugin : Execute Result 0
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Audit Monitor Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : CServiceModule::Handler
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {6A231542-849D-419D-9546-583D2B6291DD}
Track-It! : Track-It! Software License Management Plugin : Loaded
Track-It! : Track-It! Software License Management Plugin : Executing
Track-It! : Track-It! Software License Management Plugin : Execute Result 1
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Software License Management Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {D64B2D68-8A18-41C0-8236-E71CA940FAA3} : not scheduled to execute yet.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {E58E22ED-C85F-4953-9FCC-A725D6C5D535} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {23765589-D75B-41E5-8DD2-EC160695F2EF} : not scheduled to execute yet.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : (null) : Wait BREAK
Track-It! : {946E254C-93C6-493E-9C43-B52EF88ED705} : not enabled.
Track-It! : (null) : Wait Ended
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Done Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : {7BBF76B1-464C-4C2C-A5B4-DBBD96E54B84} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : CServiceModule::Handler
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : {1AF8CF82-9FB4-42D5-AC40-0D046B956C09} : not enabled.
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {26DE80E5-11C1-4891-B020-5E74E5D736E2}
Track-It! : Track-It! Data Maintenance Plugin : Loaded
Track-It! : Track-It! Data Maintenance Plugin : Executing
Track-It! : Track-It! Data Maintenance Plugin : Execute Result 0
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Data Maintenance Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {D9E8BDD8-4FAF-42A6-A084-D21D06CF82B1}
Track-It! : Track-It! Audit Monitor Plugin : Loaded
Track-It! : Track-It! Audit Monitor Plugin : Executing
Track-It! : Track-It! Audit Monitor Plugin : Execute Result 0
Track-It! : Start unloading plugin ...
Track-It! : Track-It! Audit Monitor Plugin : Unloaded
Track-It! : (null) : Waiting 60000
Track-It! : (null) : Waiting : 60000
beserver: 11/27/06 10:43:13 -1 Starting beserver system service application
beserver: 11/27/06 10:43:13 -1 Entered RpcXfaceServiceMain.
beserver: 11/27/06 10:43:13 -1 Sending start status to scm. (hint 300000)..
beserver: 11/27/06 10:43:13 -1 Initializing ACE...
beserver: 11/27/06 10:43:13 -1 Cblmanger, shutdown Immenient: started.
beserver: 11/27/06 10:43:13 -1 Cblmanger, shutdown Immenient: complete.
beserver: 11/27/06 10:43:13 -1 Cblmanger, check shutdown Ready: started.
beserver: 11/27/06 10:43:13 -1 Cblmanger, check shutdown ready: complete.
beserver: 11/27/06 10:43:14 -1 Initializing work queue...
beserver: 11/27/06 10:43:14 -1 Initializing Persistent Store (AHNTSBS1\BkupExec, BEDB, Backup Exec Server, 30 seconds)...
beserver: 11/27/06 10:43:14 -1 Attemp to GetMyPartition ComputerName=AHNTSBS1 PartitionID=0 PartitionGUID=98e3cb38-db9a-49f3-8cd8-a3c56126db1c
beserver: 11/27/06 10:43:14 -1 InitializePartition() Data partition ID from registry=0
beserver: 11/27/06 10:43:14 -1 GetMyPartition() Data partition to use for 'AHNTSBS1' is 0
beserver: 11/27/06 10:43:14 -1 InitializePartition() returning 0x0
beserver: 11/27/06 10:43:14 -1 Successfully GetMyPartition ComputerName=AHNTSBS1 PartitionID=0 PartitionGUID=98e3cb38-db9a-49f3-8cd8-a3c56126db1c
beserver: 11/27/06 10:43:14 -1 InitializePartition() ok, partitionID=0, oldComputerName=
beserver: 11/27/06 10:43:14 -1 Creating Business Objects...
beserver: 11/27/06 10:43:14 00 VSN BO Initialization succeeded.
beserver: 11/27/06 10:43:15 -1 FillServerInfo: cw.Open() failed.
beserver: 11/27/06 10:43:15 -1 ServerName:AHNTSBS1, ActiveNodeName:,
InstanceName:BkupExec, DatabaseName:BEDB.
beserver: 11/27/06 10:43:15 01 Server Configuration: BEServer schema version checks OK.
beserver: 11/27/06 10:43:15 01 Server Configuration: Initialization Complete.
beserver: 11/27/06 10:43:15 02 Ownership: Initialization Complete.
beserver: 11/27/06 10:43:15 03 JobManBO: starting initialization...
beserver: 11/27/06 10:43:15 03 JobManBO: initialization complete...
beserver: 11/27/06 10:43:15 04 CAuditLogBO: Initialization completed.
beserver: 11/27/06 10:43:15 05 LoginAccount: Initialization Complete. BO=5.
beserver: 11/27/06 10:43:15 06 Resource: Initialization Complete.
beserver: 11/27/06 10:43:15 07 ServersBO: Initialization Complete.
beserver: 11/27/06 10:43:15 08 CMediaServerPoolBO: Initialization completed.
beserver: 11/27/06 10:43:15 09 ScriptMgrBO: Initialization Complete. BO=9.
beserver: 11/27/06 10:43:15 10 MessageQueue: Initialization Started.
beserver: 11/27/06 10:43:15 10 MessageQueue: Not licensed for DDM.
beserver: 11/27/06 10:43:15 10 MessageQueue: Initialization Complete.
beserver: 11/27/06 10:43:15 11 Djm: pMMSFeature is null, mmsUsable set to FALSE.
beserver: 11/27/06 10:43:15 11 Djm: pCASOFeature is null, casoUsable set to FALSE.
beserver: 11/27/06 10:43:15 11 Djm: mmsUsable is FALSE, so setting DjmEnabled to FALSE.
beserver: 11/27/06 10:43:15 11 DjmBO=11. : Initialization Complete.
CASO:0, APPO:0, DjmEnabled:0, Mgr:0, Clt:0, CasoServer:. nRetval=0x0.
beserver: 11/27/06 10:43:15 12 AdammAdminBO: Initialization Complete.
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Execute() - ADAMM_ADMIN_QUERY_ENTITY_BY_NAME.
pvlsvr: 11/27/06 10:43:15 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MACHINE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ."
EntityFlags = 0x00000100
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Get() - Parent = NULL , Entity = DEVICE
pvlsvr: 11/27/06 10:43:15 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DEVICE_ENTITY_TYPE
EntityGuid = {0E8CD256-ABE6-49D8-8507-E32DCCAC00B5}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Get() - hr = 0x0
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA_SET
pvlsvr: 11/27/06 10:43:15 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_SET_ENTITY_TYPE
EntityGuid = {00000009-03E8-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:15 12 AdammAdminBO::Get() - hr = 0x0
beserver: 11/27/06 10:43:15 13 AdammUtilBO: Initialization Complete.
beserver: 11/27/06 10:43:15 14 Reports: Using default language = ENU
beserver: 11/27/06 10:43:15 14 Reports: Initialize for language = 1
beserver: 11/27/06 10:43:15 14 Reports: Setting remote server locations.
beserver: 11/27/06 10:43:16 14 Reports: Loading any new reports.
beserver: 11/27/06 10:43:16 14 Reports: Report Engine started.
beserver: 11/27/06 10:43:16 14 Reports: Initialization Complete.
beserver: 11/27/06 10:43:16 15 Job Completion BO: Initialization Complete.
beserver: 11/27/06 10:43:16 16 Job History: Initialization Complete.
beserver: 11/27/06 10:43:16 17 JobManager: starting initialization...
beserver: 11/27/06 10:43:16 17 JobManager: Initializing CAdammData...
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Execute() - ADAMM_ADMIN_QUERY_ENTITY_BY_NAME.
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MACHINE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ."
EntityFlags = 0x00000100
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = PVL
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = PVL_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_TYPE
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_TYPE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = MACHINE
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MACHINE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DEVICE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL_DEVICE
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DEVICE_POOL_DEVICE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = PARTITION
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = PARTITION_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = NULL , Entity = SLOT
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = SLOT_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:16 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
pvlsvr: 11/27/06 10:43:16 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = BACKUP_TO_DISK_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DEVICE_POOL_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DRIVE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = CHANGER
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = LIBRARY_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_SET
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_SET_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = NULL , Entity = VAULT
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = VAULT_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = NULL , Entity = VAULT_MEDIA_RULE
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = VAULT_MEDIA_RULE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_SET_VAULT_MEDIA_RULE
pvlsvr: 11/27/06 10:43:17 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_SET_VAULT_MEDIA_RULE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:17 12 AdammAdminBO::Query() - hr = 0x0
beserver: 11/27/06 10:43:17 17 CJobManager::Deinitialize( :( killing dispatcher...
beserver: 11/27/06 10:43:17 17 CJobManager::Deinitialize( :( flushing cache...
beserver: 11/27/06 10:43:17 17 CJobManager::Deinitialize( :( empty cache...
beserver: 11/27/06 10:43:17 17 CJobManager::Deinitialize( :( remove alert monitor...
beserver: 11/27/06 10:43:17 17 CJobManager::Deinitialize( :( complete!
beserver: 11/27/06 10:43:17 17 CJObManager::Initialize( ) - initializing cache...
beserver: 11/27/06 10:43:17 17 CJobManager::Initialize( ) - loading schedules...
beserver: 11/27/06 10:43:17 17 CJobManager::Initialize( ) - 11 schedules loaded
beserver: 11/27/06 10:43:17 17 Job Dispatcher: GetServerIsRunningOnCluster()==FALSE
beserver: 11/27/06 10:43:17 17 Job Dispatcher: UseClusterRestart=0
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( loading task definitions...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( loading solutions...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( loading work items...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( loading policies...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( making solution associations...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( generating workitem linkages...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( recovering tasks...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( DJM cleanup...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( flushing cache...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( DJM startup synchronization...
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( cached 2 policies
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( cached 3 solutions
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( cached 3 work items
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( cached 1 scripts
beserver: 11/27/06 10:43:17 17 CJobManager::LoadAllJobData( :( starting dispatch processing thread
beserver: 11/27/06 10:43:17 17 JobManager: m_JobManager->Initialize() err=0x0
beserver: 11/27/06 10:43:17 17 JobManager: m_IsUsingJoinView = true
beserver: 11/27/06 10:43:17 17 **** THE JOB MANAGER IS USING JOIN VIEW!!! ****
beserver: 11/27/06 10:43:17 17 JobManager: initialization complete...
beserver: 11/27/06 10:43:17 18 Notification: Initialization Starting.
beserver: 11/27/06 10:43:18 18 DBConnection str Driver={SQL Server};Server=AHNTSBS1\BkupExec;database=BEDB;
beserver: 11/27/06 10:43:18 18 Notification: Initialization Complete.
beserver: 11/27/06 10:43:18 19 CAlertConfigurationBO: Initialization completed.
beserver: 11/27/06 10:43:18 20 CAlertBO: Initialization completed.
beserver: 11/27/06 10:43:18 21 Usershares: Initialization Complete.
beserver: 11/27/06 10:43:18 22 ServerObjects: Initialization Complete.
beserver: 11/27/06 10:43:18 23 JobLogBO: Initialization Complete.
beserver: 11/27/06 10:43:18 24 Catalog BO initialization succeeded.
beserver: 11/27/06 10:43:18 25 PersistentStore: Runtime (UTC): 10/29/2006 10:00:00; Last run (UTC): 11/27/2006 10:00:00
beserver: 11/27/06 10:43:18 25 PersistentStore: initialization complete...
beserver: 11/27/06 10:43:18 26 Copy Job: Initialization Complete.
beserver: 11/27/06 10:43:18 27 CAuditConfigurationBO: Initialization completed.
beserver: 11/27/06 10:43:18 28 CDebugBO: Initialization Complete.
beserver: 11/27/06 10:43:18 09 ScriptMgrBO: CreateDefaultScripts returns:0, 0x0.
beserver: 11/27/06 10:43:18 13 AdammUtilBO: Activate Complete.
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
pvlsvr: 11/27/06 10:43:18 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {D64EAADF-36DB-4C41-AE1A-001F6E5211FA}
EntityType = DRIVE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
pvlsvr: 11/27/06 10:43:18 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {D64EAADF-36DB-4C41-AE1A-001F6E5211FA}
EntityType = BACKUP_TO_DISK_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
pvlsvr: 11/27/06 10:43:18 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {D64EAADF-36DB-4C41-AE1A-001F6E5211FA}
EntityType = DRIVE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
pvlsvr: 11/27/06 10:43:18 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {D64EAADF-36DB-4C41-AE1A-001F6E5211FA}
EntityType = BACKUP_TO_DISK_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
beserver: 11/27/06 10:43:18 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 11/27/06 10:43:18 -1 Initializing virtual array manager...
beserver: 11/27/06 10:43:18 -1 BO Layer: Initialized.
beserver: 11/27/06 10:43:18 -1 Creating connection points...
beserver: 11/27/06 10:43:18 -1 Initializing SNMP...
beserver: 11/27/06 10:43:18 -1 Call NTREG_RpcInit()
beserver: 11/27/06 10:43:18 -1 Starting RPC Server...
beserver: 11/27/06 10:43:18 -1 Registered protocol ncacn_np, \pipe\BEMapi_rpc.
beserver: 11/27/06 10:43:18 -1 Registered protocol ncalrpc, BEMAPI_LocalRPC.
beserver: 11/27/06 10:43:18 -1 Registered protocol ncacn_ip_tcp, 6106.
beserver: 11/27/06 10:43:18 -1 Server RPC started listening.
beserver: 11/27/06 10:43:18 -1 Setting startup event...
beserver: 11/27/06 10:43:18 -1 Sending running status to SCM...
beserver: 11/27/06 10:43:18 -1 Account name: AHVINCENT\administrator
beserver: 11/27/06 10:43:18 -1 Sending startup alert...
beserver: 11/27/06 10:43:19 18 Alert Service Start, Notify: No, EventLog: Yes, Trap: No
beserver: 11/27/06 10:43:19 -1 Server started, awaiting requests...
Track-It! : CServiceModule::Handler
Track-It! : (null) : Wait BREAK
Track-It! : (null) : Wait Ended
Track-It! : (null) : Done Waiting 60000
Track-It! : Start loading plugin ...
Track-It! : Automation Server is loading : {6A231542-849D-419D-9546-583D2B6291DD}
Track-It! : Track-It! Software License Management Plugin : Loaded
Track-It! : Track-It! Software License Management Plugin : Executing
beserver: 11/27/06 10:43:22 -1 Client requested key.
beserver: 11/27/06 10:43:22 -1 Client 'AHNTSBS1' connected('','AHVINCENT\administrator'): 0x1552cd8
bengine: 11/27/06 10:43:22 DeviceManager thread starting
bengine: 11/27/06 10:43:22 DeviceManager thread ready
bengine: 11/27/06 10:43:22 DeviceManager: going to sleep for 900000 msecs
bengine: 11/27/06 10:43:23 ImageBasedFHPlugin::ImageBasedFHPlugin() - Entering.
bengine: 11/27/06 10:43:23 ImageBasedFHPlugin::ImageBasedFHPlugin() - Exiting.
bengine: 11/27/06 10:43:23 ImageBasedFHPlugin::init() - Entering.
bengine: 11/27/06 10:43:23 ImageBasedFHPlugin::init() - Parameters:
bengine: 11/27/06 10:43:23 ImageBasedFHPlugin::init() - Exiting.
bengine: 11/27/06 10:43:23 LegacyBEPlugin::LegacyBEPlugin() - Entering.
bengine: 11/27/06 10:43:23 LegacyBEPlugin::LegacyBEPlugin() - Exiting.
bengine: 11/27/06 10:43:23 LegacyBEPlugin::init() - Entering.
bengine: 11/27/06 10:43:23 LegacyBEPlugin::init() - Parameters:
bengine: 11/27/06 10:43:23 LegacyBEPlugin::init() - Exiting.
bengine: 11/27/06 10:43:23 BEImage::BEImage() - Entering.
bengine: 11/27/06 10:43:23 BEImage::BEImage() - Exiting.
bengine: 11/27/06 10:43:23 BEImage::init() - Entering.
bengine: 11/27/06 10:43:23 BEImage::init() - Parameters:
bengine: 11/27/06 10:43:23 BEImage::init() - Exiting.
bengine: 11/27/06 10:43:23 FS_InitFileSys
bengine: 11/27/06 10:43:23 Initializing FSs
bengine: 11/27/06 10:43:23 Initializing SNMP traps
bengine: 11/27/06 10:43:23 Catalog path: C:\Program Files\VERITAS\Backup Exec\NT\Catalogs\
bengine: 11/27/06 10:43:23 Data path: C:\Program Files\VERITAS\Backup Exec\NT\Data\
bengine: 11/27/06 10:43:23 Log file root: BEX
bengine: 11/27/06 10:43:23 Software Edition: Unhandled edition
bengine: 11/27/06 10:43:23 NSE: 0
bengine: 11/27/06 10:43:23 Authorized Agents:
bengine: 11/27/06 10:43:23 AUTH_AGENT_DOS
bengine: 11/27/06 10:43:23 AUTH_AGENT_WIN16
bengine: 11/27/06 10:43:23 AUTH_AGENT_OS2
bengine: 11/27/06 10:43:23 AUTH_AGENT_WIN95
bengine: 11/27/06 10:43:23 AUTH_AGENT_UNIX
bengine: 11/27/06 10:43:23 AUTH_AGENT_MAC
bengine: 11/27/06 10:43:23 AUTH_AGENT_SQL2
bengine: 11/27/06 10:43:23 AUTH_AGENT_SQLS
bengine: 11/27/06 10:43:23 AUTH_AGENT_XCH
bengine: 11/27/06 10:43:23 AUTH_AGENT_ESE
bengine: 11/27/06 10:43:23 AUTH_AGENT_CPS
bengine: 11/27/06 10:43:23 WinNT information: 5.2 (3790) SP 1.0 "Service Pack 1"
bengine: 11/27/06 10:43:23 WinNT ProductType: 2 "LanmanNT"
bengine: 11/27/06 10:43:23 WinNT ProductSuite: 0x0131
bengine: 11/27/06 10:43:23 Small Business
bengine: 11/27/06 10:43:23 Small Business(Restricted)
bengine: 11/27/06 10:43:23 Terminal Server
bengine: 11/27/06 10:43:23 JobStatus thread starting
bengine: 11/27/06 10:43:23 Server listening on RPC endpoint 'BackupExecJobRunner'
bengine: 11/27/06 10:43:23 Running... 'Q' to stop

[Mark_O_Loughlin]

I have the exact same problem with Backup Exec v9.1 on Windows 2003 SBS, both running all the latest patches & updates.

Before I also go down this path of running SGMON I have a question:
Considering that these services always startup fine when starting them manually, will the SGMON actually show anything?

The failure to start/timeout of these services only occurs during a windows restart/reboot. Can SGMON be used to log these errors during system startup? If not, then I suspect SGMON may be of no use to us.

If SGMON cannot be used at system startup, what else can be done to troubleshoot this?

[Ben_Hayes]

Still Looking for an Anser on this. Any other suggestions out there???

Thanks