3 Replies Latest reply on May 12, 2015 5:35 AM by Raphael Kariger

    RSCD Agent on VCenter - Cannot execute Job

      Hi all,

       

      I need your help to understand my issue.

      I have added five new Vcenter servers in my console, i m able to "Verify" and browse those servers, BUT, i m not able to execute any job on those server.

       

      See few information :

       

      Server automation version - 8.3.00.115

      agent version of my vcenter :

       

        Agent Release   : 8.3.00.115

        Hostname        : XW01LVICK100

        Operating System: WindowsNT 6.2 (x86_64)

        User Permissions: BladeLogicRSCD@XW01LVICK100->Anonymous:PrivilegeMapped (Iden

      tity via trust)

        Security        : Protocol=5, Encryption=TLS1

        Host ID         : EC4B99DE

        # of Processors : 4

        License Status  : Licensed for NSH/CM

       

      RSCDlog

       

      77dcd9bafe179d0fc338 0000002486 04/30/15 07:32:31.374 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      44a4d14653d5e7e189b9 0000002487 04/30/15 07:42:31.374 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      ffc3e283a32970bcd79a 0000002488 04/30/15 07:52:31.375 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      c719c7eb8ec313746d15 0000002489 04/30/15 08:02:31.375 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      75c5659a88d911ec7437 0000002490 04/30/15 08:12:31.375 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      ce96dc4bec08e0a533c6 0000002491 04/30/15 08:22:31.376 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      5654faa04969c9def52d 0000002492 04/30/15 08:32:31.376 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      8eab9cb716d19a407d26 0000002493 04/30/15 08:42:31.377 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      cddd6db2687ea4521497 0000002494 04/30/15 08:52:31.377 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      f7df2ce93a376eb8acbf 0000002495 04/30/15 09:02:31.378 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      edf4637417be7ce81a2e 0000002496 04/30/15 09:12:31.379 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      28f984bf6569faaa0e76 0000002497 04/30/15 09:22:31.379 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      06f0b8fb9dae830b9861 0000002498 04/30/15 09:32:31.380 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      875397ff3b4b04e5f991 0000002499 04/30/15 09:42:31.380 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      5fed6d81c7c5d8199496 0000002500 04/30/15 09:52:31.381 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      e17947d12b9b640e8f7a 0000002501 04/30/15 10:02:31.381 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      65fb436c1c06d8ab58bb 0000002502 04/30/15 10:02:36.526 INFO     rscd -  XW01LVICK100 10484 SYSTEM (Not_available): (Not_available): Adding account right "SeDenyInteractiveLogonRight" to user BladeLogicRSCD@XW01LVICK100 for user privilege mapping

      45bdc6035070a83c5f39 0000002503 04/30/15 10:02:36.535 INFO     rscd -  10.136.166.39 10484 BladeLogicRSCD@XW01LVICK100->Anonymous:PrivilegeMapped (spr-xqd0u): agentinfo: agentinfo 10.169.129.40

      616ccbe7b5906b5f6118 0000002504 04/30/15 10:02:36.539 INFO     rscd -  XW01LVICK100 10484 BladeLogicRSCD (Not_available): (Not_available): The operation completed successfully.

      bddc0307c697155f6f90 0000002505 04/30/15 10:12:31.381 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      f912004468a392211dba 0000002506 04/30/15 10:22:31.382 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      6f967cf537d7de8cb76b 0000002507 04/30/15 10:32:31.382 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      2e163914fa322b3d6d17 0000002508 04/30/15 10:42:31.383 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      973a4a7c1804de2adb40 0000002509 04/30/15 10:52:31.383 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      db1af73c235854fe318b 0000002510 04/30/15 11:02:31.383 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      3c3c1177ee57a57ecffe 0000002511 04/30/15 11:12:31.384 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      532308c16b20d3fc9a8c 0000002512 04/30/15 11:17:32.063 INFO1    rscd -  10.136.166.39 12944 BladeLogicRSCD@XW01LVICK100->administrator@XW01LVICK100:PrivilegeMapped (BLAdmins:BLAdmin): CM: > [Client] Retrieving the root filesystem

      5254abaadc6045a497fb 0000002513 04/30/15 11:17:37.907 INFO1    rscd -  10.136.166.39 8252 BladeLogicRSCD@XW01LVICK100->administrator@XW01LVICK100:PrivilegeMapped (BLAdmins:BLAdmin): CM: > [Client] Retrieving '/C'

      5591de11e22b1595da74 0000002514 04/30/15 11:22:31.385 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

      e957cb15b36fb0e397d9 0000002515 04/30/15 11:32:31.386 WARN     rscd -  XW01LVICK100 3688 SYSTEM (Not_available): (Not_available): Main: Wait Timeout. Starting AgentHouseKeeping.

       

       

      bltargetjobmanager

       

      04/30/15 11:36:41.697 DEBUG    bldeploy - TJM invoked with arguments:

      04/30/15 11:36:41.698 DEBUG    bldeploy - args 0 = bltargetjobmanager

      04/30/15 11:36:41.698 DEBUG    bldeploy - args 1 = -start

      04/30/15 11:36:41.699 DEBUG    bldeploy - args 2 = -cmd

      04/30/15 11:36:41.699 DEBUG    bldeploy - args 3 = bldeploy 05e03e72e5b134c9be5c8c14379ee4b0 -N=/temp/stage/7b2b0585da233e9293fd8660e8fcca09 -P=XW01LVICK100 -Q=params.txt -PKG=SIA-51734.1 -DryRun -Xr -V1 -js0 -jr0 -jc0

      04/30/15 11:36:41.700 DEBUG    bldeploy - args 4 = -me

      04/30/15 11:36:41.701 DEBUG    bldeploy - args 5 = 05e03e72e5b134c9be5c8c14379ee4b0

      04/30/15 11:36:41.701 DEBUG    bldeploy - args 6 = -mp

      04/30/15 11:36:41.701 DEBUG    bldeploy - args 7 = -sp

      04/30/15 11:36:41.701 DEBUG    bldeploy - args 8 = -ps

      04/30/15 11:36:41.701 DEBUG    bldeploy - args 9 = -h60

      04/30/15 11:36:41.701 DEBUG    bldeploy - BlTargetJobManager started

      04/30/15 11:36:41.701 DEBUG    bldeploy - Commandline: bltargetjobmanager -start -cmd bldeploy 05e03e72e5b134c9be5c8c14379ee4b0 -N=/temp/stage/7b2b0585da233e9293fd8660e8fcca09 -P=XW01LVICK100 -Q=params.txt -PKG=SIA-51734.1 -DryRun -Xr -V1 -js0 -jr0 -jc0  -me 05e03e72e5b134c9be5c8c14379ee4b0 -mp -sp -ps -h60

      04/30/15 11:36:41.703 DEBUG    bldeploy - Found path to cmd at C:\Program Files\BMC Software\BladeLogic\RSCD\sbin/bldeploy.exe

      04/30/15 11:36:41.704 DEBUG    bldeploy - Executing "C:\Program Files\BMC Software\BladeLogic\RSCD\sbin\bldeploy.exe" 05e03e72e5b134c9be5c8c14379ee4b0 -N=/temp/stage/7b2b0585da233e9293fd8660e8fcca09 -P=XW01LVICK100 -Q=params.txt -PKG=SIA-51734.1 -DryRun -Xr -V1 -js0 -jr0 -jc0  -StartNew

      04/30/15 11:36:41.704 DEBUG    bldeploy - ProcessExecutor::createProcess batchFile=, cmd="C:\Program Files\BMC Software\BladeLogic\RSCD\sbin\bldeploy.exe" 05e03e72e5b134c9be5c8c14379ee4b0 -N=/temp/stage/7b2b0585da233e9293fd8660e8fcca09 -P=XW01LVICK100 -Q=params.txt -PKG=SIA-51734.1 -DryRun -Xr -V1 -js0 -jr0 -jc0  -StartNew, cmdDir=

      04/30/15 11:36:42.308 DEBUG    bldeploy - Compare to blp_prog=bldeploy.exe

      04/30/15 11:36:42.308 DEBUG    bldeploy - Command has started

      04/30/15 11:36:42.308 DEBUG    bldeploy - PID not valid 7716 for bldeploy

      04/30/15 11:36:42.310 ERROR    bldeploy - Application terminated unexpectedly

      04/30/15 11:36:42.311 DEBUG    bldeploy - Deleted event file: C:\Program Files\BMC Software\BladeLogic\RSCD\\Transactions\events\05e03e72e5b134c9be5c8c14379ee4b0.out

      04/30/15 11:36:42.312 DEBUG    bldeploy - Deleted event file: C:\Program Files\BMC Software\BladeLogic\RSCD\\Transactions\events\05e03e72e5b134c9be5c8c14379ee4b0.in

      04/30/15 11:36:42.313 DEBUG    bldeploy - TJM generated Exit message: exitCode=-5005: MSG=The bldeploy process terminated unexpectedly. See bldeploy transactions log to determine reason for failure. ( exitCode = -5005 ):

      04/30/15 11:36:42.313 DEBUG    bldeploy - Operation complete return code -5005

       

      appserver

       

      [30 Apr 2015 11:32:30,676] [Scheduled-System-Tasks-Thread-9] [INFO] [System:System:] [Memory Monitor] Total JVM (B): 196214784,Free JVM (B): 22734744,Used JVM (B): 173480040,VSize (B): 482754560,RSS (B): 475590656,Used File Descriptors: 23034

      [30 Apr 2015 11:33:30,677] [Scheduled-System-Tasks-Thread-13] [INFO] [System:System:] [Memory Monitor] Total JVM (B): 195887104,Free JVM (B): 17193824,Used JVM (B): 178693280,VSize (B): 482230272,RSS (B): 475107328,Used File Descriptors: 23026

      [30 Apr 2015 11:34:00,131] [Client-Connections-Thread-9] [INFO] [BLAdmin:BLAdmins:10.136.166.55] [Client] Connection disconnecting: id = 1282

      [30 Apr 2015 11:34:06,662] [Client-Connections-Thread-7] [INFO] [BLAdmin:BLAdmins:10.136.166.55] [Client] User 'BLAdmin' assumed the role 'BLAdmins'

      [30 Apr 2015 11:34:30,678] [Scheduled-System-Tasks-Thread-15] [INFO] [System:System:] [Memory Monitor] Total JVM (B): 196149248,Free JVM (B): 17911728,Used JVM (B): 178237520,VSize (B): 481636352,RSS (B): 474472448,Used File Descriptors: 23036

      [30 Apr 2015 11:35:30,679] [Scheduled-System-Tasks-Thread-1] [INFO] [System:System:] [Memory Monitor] Total JVM (B): 195887104,Free JVM (B): 19554968,Used JVM (B): 176332136,VSize (B): 481374208,RSS (B): 474165248,Used File Descriptors: 23034

      [30 Apr 2015 11:36:28,773] [Client-Connections-Thread-0] [INFO] [BLAdmin:BLAdmins:10.128.111.227] [Client] Executing <Execute Against> Action against group targets:  for job: /Vincent/TT/SIA/SIA

      [30 Apr 2015 11:36:30,679] [Scheduled-System-Tasks-Thread-8] [INFO] [System:System:] [Memory Monitor] Total JVM (B): 195166208,Free JVM (B): 21983168,Used JVM (B): 173183040,VSize (B): 482316288,RSS (B): 473571328,Used File Descriptors: 23037

      [30 Apr 2015 11:36:32,242] [Job-Execution-1] [INFO] [BLAdmin:BLAdmins:] [Deploy] Started running the job 'SIA' with priority 'NORMAL' on application server 'ULUCSBSA002P'(1)

      [30 Apr 2015 11:36:36,070] [Lightweight-WorkItem-Thread-99] [INFO] [BLAdmin:BLAdmins:] [Deploy] Executing work item Deploy Dry Run Job (Pre-Execute):SIA; Server:XW01LVICK100;  on application server: ULUCSBSA002P

      [30 Apr 2015 11:36:44,086] [Lightweight-WorkItem-Thread-27] [INFO] [BLAdmin:BLAdmins:] [Deploy] Executing work item Deploy Dry Run Job (Post-Execute):SIA; Server:XW01LVICK100;  on application server: ULUCSBSA002P

      [30 Apr 2015 11:36:44,351] [Client-Connections-Thread-0] [INFO] [BLAdmin:BLAdmins:10.128.111.17] [Client] Connection disconnecting: id = 1269

      [30 Apr 2015 11:36:46,148] [Lightweight-WorkItem-Thread-27] [ERROR] [BLAdmin:BLAdmins:] [Deploy] DRYRUN failed for server XW01LVICK100. Exit code = -5005

      [30 Apr 2015 11:36:46,148] [Lightweight-WorkItem-Thread-27] [ERROR] [BLAdmin:BLAdmins:] [Deploy] SIA->SIA failed on server XW01LVICK100 exit code = -5005

      [30 Apr 2015 11:36:46,180] [Job-Execution-1] [INFO] [BLAdmin:BLAdmins:] [Deploy] Phase: Dry-run completed with errors for target: XW01LVICK100

      [30 Apr 2015 11:36:46,180] [Job-Execution-1] [ERROR] [BLAdmin:BLAdmins:] [Deploy] The job 'SIA' has failed

       

       

       

      If you need any other log, please feel free to ask me.

       

      many thx in advance ...

       

      Best regards

      raphael

       

      PS : The JOB that i try on VCenter, works perfectly on all other Server ...