Network Management

 View Only
last person joined: 5 hours ago 

Keep an informative eye on your network with IMC and AirWave network management solutions.
Expand all | Collapse all

iMC Backup failed - SSH Failure

This thread has been viewed 2 times
  • 1.  iMC Backup failed - SSH Failure

    Posted Aug 11, 2022 10:20 PM
    Hi,

    When trying to backup some of our switches in iMC we get an SSH failure error
    When we test SSH under device details SSH is working perfectly

    I found a similar post (Backup switches config FAILED - Hewlett Packard Enterprise Community (hpe.com))  suggesting forcing putty version 7 by adding a blank file named putty07 but this is already present.
    The solution in the above post was to change the SSH credentials from private key to password but for is this is already the case.

    When i check the log is see the following

    2022-08-11 14:12:27.230 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] File :C:\Program Files\iMC\server\bin\..\..\server/tmp/scripttool_15312_3717297563.cfg is deleted
    2022-08-11 14:12:27.230 [ERROR (7)] [THREAD(12960)] [CScriptProcessor::exec()] Failed to execute by cli method.
    2022-08-11 14:12:27.230 [INFO (7)] [THREAD(12960)] [CScriptProcessor::exec()] Finished to execute, result:
    ServiceName = ConfigBackup
    ActionName = backup_running_config
    InputParam = DevName=SW141-21?_?TFTPFile=running_3717297562.cfg?_?TFTPServer=192.168.7.65?_?UnitList=?_?VpnName=
    OutputParam =
    CmdResp =

    ErrorMessage =
    ActionResult = 7

    2022-08-11 14:12:27.230 [ERROR (7)] [THREAD(12960)] [CThirdPartCfgfileMgr::__backup()] Failed to call CScriptProcessor::exec().step_detail:
    , error_message:
    2022-08-11 14:12:27.230 [INFO (6120)] [THREAD(12960)] [CThirdPartCfgfileMgr::backupRunning()] End to backup running cfgfile.
    2022-08-11 14:12:28.232 [WARNING (2023)] [THREAD(12960)] [CScriptTool::getDevAdapterNameFromDB()] reader no data, sql: select vendor_name,adapter_name,error_code from tbl_dev_adapter where component_name = 'ICC' and dev_id = 354 and adapter_type = 1
    2022-08-11 14:12:28.232 [INFO (0)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] begin ...
    2022-08-11 14:12:28.233 [INFO (0)] [THREAD(12960)] [CComponentAdapter::parseVendorAdapter()] Begin to parse ...
    2022-08-11 14:12:28.233 [INFO (0)] [THREAD(12960)] [CComponentAdapter::parseVendorAdapter()] Finished to parse!
    2022-08-11 14:12:28.233 [INFO (1)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] begin...
    2022-08-11 14:12:28.234 [INFO (2047)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] ver info is ser:Dell vrp:N/A rel:N/A
    2022-08-11 14:12:28.234 [WARNING (2001)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] Not support thirdparty device,devID=354
    2022-08-11 14:12:28.234 [WARNING (44)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] fail to call getSupportAdapter(),devID=354
    2022-08-11 14:12:28.234 [DEBUG (0)] [THREAD(12960)] strAdapterName is N/A
    2022-08-11 14:12:28.234 [ERROR (44)] [THREAD(12960)] [CComponentAdapter::getDevAdapterName()] fail to call discoverDeviceAdapter()
    2022-08-11 14:12:28.234 [ERROR (44)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction()] fail to call getDevAdapterName().DevID=354,ServiceName = ConfigBackup
    2022-08-11 14:12:28.234 [DEBUG (0)] [THREAD(12960)] [CAdapterMgr::isDevSupportServiceAction] Fail to call isDevSupportServiceAction().Adapter name = N/A,Service name = ConfigBackup,Action name = backup_running_config,AccessType = 3,iTransferProtocol = 2
    2022-08-11 14:12:28.234 [INFO (0)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction] dev_id: 354, adapter_name: DellPowerSwitch1524
    2022-08-11 14:12:28.235 [INFO (0)] [THREAD(12960)] [getDevVendorTypeInCfgbak()] Dev_id : 354 , DevSysOID : 1.3.6.1.4.1.674.10895.3064
    2022-08-11 14:12:28.235 [INFO (0)] [THREAD(12960)] [CFileTransferTask::transferCfgFile()] m_iCompanyType is 0 .
    2022-08-11 14:12:28.235 [DEBUG (0)] [THREAD(12960)] [iMCKeyGenerator:: getUnallocatedNextKey()] table: tbl_cfgbak_cfgfile_info, field: cfgfile_id, key: 87534
    2022-08-11 14:12:28.235 [DEBUG (0)] [THREAD(12960)] [CFileTransferTask::transferFileEx()] strDevFileName: 172.20.45.34_startup_20220811141228.cfg, strHostFileName :startup_3717297592.cfg
    2022-08-11 14:12:28.236 [INFO (0)] [THREAD(12960)] [getDevVendorTypeInCfgbak()] Dev_id : 354 , DevSysOID : 1.3.6.1.4.1.674.10895.3064
    2022-08-11 14:12:28.236 [INFO (0)] [THREAD(12960)] [CThirdPartCfgfileMgr::backupStartup()] Begin to backup startup cfgfile ...
    2022-08-11 14:12:28.237 [INFO (0)] [THREAD(12960)] [getDevVendorTypeInCfgbak()] Dev_id : 354 , DevSysOID : 1.3.6.1.4.1.674.10895.3064
    2022-08-11 14:12:28.237 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Begin to execute, data: ServiceName = ConfigBackup
    ActionName = backup_startup_config
    InputParam = TFTPFile=startup_3717297592.cfg?_?TFTPServer=192.168.7.65?_?UnitList=?_?VpnName=
    OutputParam =
    CmdResp =
    ErrorMessage =
    ActionResult = 19

    2022-08-11 14:12:28.238 [INFO (0)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] begin ...
    2022-08-11 14:12:28.239 [INFO (0)] [THREAD(12960)] [CScriptTool::setDevAdapterName] update table tbl_dev_adapter.Sql is update tbl_dev_adapter set adapter_name = 'N/A',sysoid = '1.3.6.1.4.1.674.10895.3064',vendor_name = 'Dell',error_code = 18 where component_name = 'Custom' and dev_id = 354 and adapter_type = 1
    2022-08-11 14:12:28.240 [ERROR (18)] [THREAD(12960)] [CComponentAdapter::getDevAdapterName()] fail to call discoverDeviceAdapter()
    2022-08-11 14:12:28.240 [ERROR (18)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction()] fail to call getDevAdapterName().DevID=354,ServiceName = ConfigBackup
    2022-08-11 14:12:28.240 [DEBUG (0)] [THREAD(12960)] [CAdapterMgr::isDevSupportServiceAction] Fail to call isDevSupportServiceAction().Adapter name = N/A,Service name = ConfigBackup,Action name = backup_startup_config,AccessType = 3,iTransferProtocol = 2
    2022-08-11 14:12:28.240 [DEBUG (0)] [THREAD(12960)] [CScriptProcessor::exec()] Don't support method: custom + snmp, DevID: 354, ServiceName: ConfigBackup, ActionName: backup_startup_config, TransferProtocol: 2
    2022-08-11 14:12:28.242 [INFO (0)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] begin ...
    2022-08-11 14:12:28.242 [INFO (0)] [THREAD(12960)] [CScriptTool::setDevAdapterName] update table tbl_dev_adapter.Sql is update tbl_dev_adapter set adapter_name = 'N/A',sysoid = '1.3.6.1.4.1.674.10895.3064',vendor_name = 'Dell',error_code = 18 where component_name = 'Custom' and dev_id = 354 and adapter_type = 0
    2022-08-11 14:12:28.243 [ERROR (18)] [THREAD(12960)] [CComponentAdapter::getDevAdapterName()] fail to call discoverDeviceAdapter()
    2022-08-11 14:12:28.243 [ERROR (18)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction()] fail to call getDevAdapterName().DevID=354,ServiceName = ConfigBackup
    2022-08-11 14:12:28.243 [DEBUG (0)] [THREAD(12960)] [CAdapterMgr::isDevSupportServiceAction] Fail to call isDevSupportServiceAction().Adapter name = N/A,Service name = ConfigBackup,Action name = backup_startup_config,AccessType = 2,iTransferProtocol = 2
    2022-08-11 14:12:28.243 [DEBUG (0)] [THREAD(12960)] [CScriptProcessor::exec()] Don't support method: custom + cli, DevID: 354, ServiceName: ConfigBackup, ActionName: backup_startup_config, TransferProtocol: 2
    2022-08-11 14:12:28.244 [WARNING (2023)] [THREAD(12960)] [CScriptTool::getDevAdapterNameFromDB()] reader no data, sql: select vendor_name,adapter_name,error_code from tbl_dev_adapter where component_name = 'ICC' and dev_id = 354 and adapter_type = 1
    2022-08-11 14:12:28.244 [INFO (0)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] begin ...
    2022-08-11 14:12:28.245 [INFO (0)] [THREAD(12960)] [CComponentAdapter::parseVendorAdapter()] Begin to parse ...
    2022-08-11 14:12:28.245 [INFO (0)] [THREAD(12960)] [CComponentAdapter::parseVendorAdapter()] Finished to parse!
    2022-08-11 14:12:28.245 [INFO (1)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] begin...
    2022-08-11 14:12:28.246 [INFO (2047)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] ver info is ser:Dell vrp:N/A rel:N/A
    2022-08-11 14:12:28.246 [WARNING (2001)] [THREAD(12960)] [CComponentAdapter::getSupportAdapter()] Not support thirdparty device,devID=354
    2022-08-11 14:12:28.246 [WARNING (44)] [THREAD(12960)] [CComponentAdapter::discoverDeviceAdapter()] fail to call getSupportAdapter(),devID=354
    2022-08-11 14:12:28.246 [DEBUG (0)] [THREAD(12960)] strAdapterName is N/A
    2022-08-11 14:12:28.246 [ERROR (44)] [THREAD(12960)] [CComponentAdapter::getDevAdapterName()] fail to call discoverDeviceAdapter()
    2022-08-11 14:12:28.246 [ERROR (44)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction()] fail to call getDevAdapterName().DevID=354,ServiceName = ConfigBackup
    2022-08-11 14:12:28.246 [DEBUG (0)] [THREAD(12960)] [CAdapterMgr::isDevSupportServiceAction] Fail to call isDevSupportServiceAction().Adapter name = N/A,Service name = ConfigBackup,Action name = backup_startup_config,AccessType = 3,iTransferProtocol = 2
    2022-08-11 14:12:28.246 [DEBUG (0)] [THREAD(12960)] [CScriptProcessor::exec()] Don't support method: SNMP, DevID: 354, ServiceName: ConfigBackup, ActionName: backup_startup_config, TransferProtocol: 2
    2022-08-11 14:12:28.246 [INFO (0)] [THREAD(12960)] [CComponentAdapter::isDevSupportServiceAction] dev_id: 354, adapter_name: DellPowerSwitch1524
    2022-08-11 14:12:28.246 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Begin to execute by cli.
    2022-08-11 14:12:28.247 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Case_no: 15312_3717297593, service_name: ConfigBackup, action_name: backup_startup_config, input_vars: DevName=SW141-21?_?TFTPFile=startup_3717297592.cfg?_?TFTPServer=192.168.7.65?_?UnitList=?_?VpnName=
    2022-08-11 14:12:28.247 [INFO (0)] [THREAD(12960)] Command is imcscripttool.exe -d 354 -c 15312_3717297593 -m "ICC" -s "ConfigBackup" -a "backup_startup_config" -t 2 -p "DevName=SW141-21?_?TFTPFile=startup_3717297592.cfg?_?TFTPServer=192.168.7.65?_?UnitList=?_?VpnName=".
    2022-08-11 14:12:28.249 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Success to spawn process, pid: 16856
    2022-08-11 14:12:28.729 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] ACE_Process_Manager::wait() ret_pid is 16856
    2022-08-11 14:12:28.729 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Success to execute process, pid: 16856
    2022-08-11 14:12:28.729 [INFO (0)] [THREAD(12960)] [CScriptProcessor::exec()] Check result file: C:\Program Files\iMC\server\bin\..\..\server/tmp/scripttool_15312_3717297593.cfg
    2022-08-11 14:12:29.735 [INFO (0)] [THREAD(12960)] [CScriptProcessor::processLog] File :C:\Program Files\iMC\server\bin\..\..\server\conf\log\imcscripttool_ICC_172.20.45.34.2022-08-11.txt is deleted
    2022-08-11 14:12:29.735 [INFO (0)] [THREAD(12960)] [imcscriptttol] log: =============================== Begin=============================
    2022-08-11 14:12:29.735 [INFO (0)] [THREAD(12960)]
    2022-08-11 14:12:28.298 [INFO (0)] [THREAD(10616)] [qvdm::QvGetLogFileSize] get file size from qvdm.conf: 50
    2022-08-11 14:12:28.298 [INFO (0)] [THREAD(10616)] [ScriptTool::execScriptAction()] component_name: ICC, service_name: ConfigBackup, action_name: backup_startup_config, input_vars: DevName=SW141-21?_?TFTPFile=startup_3717297592.cfg?_?TFTPServer=192.168.7.65?_?UnitList=?_?VpnName=
    2022-08-11 14:12:28.299 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::init()] Begin ...
    2022-08-11 14:12:28.300 [INFO (2001)] [THREAD(10616)] [CCLIScriptProcessor::init()] Device login type is 2,dev_id=354,AdaptName=DellPowerSwitch1524
    2022-08-11 14:12:28.302 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::init()] dev_ip is 172.20.45.34,m_oDevID:354
    2022-08-11 14:12:28.302 [INFO (0)] [THREAD(10616)] begin... : C:\Program Files\iMC\server\bin\..\..\server\conf\puttyVersion.cfg ipaddr is 172.20.45.34
    2022-08-11 14:12:28.302 [ERROR (0)] [THREAD(10616)] Fail to open config file: C:\Program Files\iMC\server\bin\..\..\server\conf\puttyVersion.cfg
    2022-08-11 14:12:28.302 [INFO (0)] [THREAD(10616)] m_strTelnetSpawn is spawn plink -telnet 172.20.45.34
    2022-08-11 14:12:28.303 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::init] use plink version is plink
    2022-08-11 14:12:28.303 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::setSpawnPhrase()] set begin
    2022-08-11 14:12:28.303 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::setSpawnPhrase()] Fail to call CSysPara::getPara() to get ssh_client.AdaptName=DellPowerSwitch1524
    2022-08-11 14:12:28.303 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::setSpawnPhrase()] Fail to call CSysPara::getPara() to get sftp_client.AdaptName=DellPowerSwitch1524
    2022-08-11 14:12:28.303 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::setSpawnPhrase()] strCommand:plink.exe -P $port [-i $key-file] $user-name@$device-ip,Version:plink
    2022-08-11 14:12:28.304 [INFO (0)] [THREAD(10616)] [CComponentAdapter::parseVendorAdapter()] Begin to parse ...
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] [CComponentAdapter::parserVendorAdapterProcess] Default: Dell3448P
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 1
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 0
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 0
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 0
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 0
    2022-08-11 14:12:28.304 [DEBUG (0)] [THREAD(10616)] begin to write in m_oDevAdapterMap,m_oDevAdapterMap is empty 0
    2022-08-11 14:12:28.304 [INFO (0)] [THREAD(10616)] [CComponentAdapter::parseVendorAdapter()] Finished to parse!
    2022-08-11 14:12:28.306 [INFO (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] begin to parse file:C:\Program Files\iMC\server\bin\..\..\server\conf\adapters\ICC\Dell\DellPowerSwitch1524\Dell_Cleanup_Parser.xml
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupPartionName
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupFreeSize
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupConfiguration
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is getDeploymentParsingSuccess
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupBoardNumber
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupTFTPConfiguration
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupImageVersion
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupImagePosition
    2022-08-11 14:12:28.306 [DEBUG (0)] [THREAD(10616)] [CParserXMLFile::parseProcess()] NODE_ATTR_NAME is cleanupImageSize
    2022-08-11 14:12:28.309 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::initEnv()] Begin ...
    2022-08-11 14:12:28.317 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::initEnv()] Success init tcl interper !
    2022-08-11 14:12:28.358 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::initEnv()] End !
    2022-08-11 14:12:28.358 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::init()] End.
    2022-08-11 14:12:28.358 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::exec_impl()] BEGIN...
    2022-08-11 14:12:28.358 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::exec_step()] exec_step action : backup_startup_config
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::exec_step()] AdaptName = DellPowerSwitch1524, ServiceName = ConfigBackup,CommandName = backup_startup_config_tftp.
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] strMethod is tftp
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::login_impl()] Begin ...
    2022-08-11 14:12:28.359 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::init()] Begin ...
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::login()] Begin ...
    2022-08-11 14:12:28.359 [DEBUG (0)] [THREAD(10616)] [CCLIScriptProcessor::init()] Begin ...
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] strSpawn:spawn plink.exe -P 22 renadmin@172.20.45.34,m_strSSHSpawn:spawn plink.exe -P 22 renadmin@172.20.45.34,m_strTelnetSpawn:spawn plink -telnet 172.20.45.34
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] [CTclExecutor::exec()] begin() ...,strTclScript:spawn plink.exe -P 22 renadmin@172.20.45.34
    2022-08-11 14:12:28.359 [INFO (0)] [THREAD(10616)] [CTclExecutor::exec_impl()] Begin to exec: spawn plink.exe -P 22 renadmin@172.20.45.34
    2022-08-11 14:12:28.359 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::exec_impl()] Success to set tcl var.
    2022-08-11 14:12:28.361 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::exec_impl()] Success to exec tcl script.
    2022-08-11 14:12:28.361 [DEBUG (0)] [THREAD(10616)] [CTclExecutor::exec_impl()] Resp:
    2022-08-11 14:12:28.361 [INFO (0)] [THREAD(10616)] [CTclExecutor::exec_impl()] Finished.
    2022-08-11 14:12:28.361 [INFO (0)] [THREAD(10616)] [CCLIScriptProcessor::gotoMode()] Begin, ip: 172.20.45.34, current mode: connect, new mode: initialize
    2022-08-11 14:12:28.361 [ERROR (-1)] [THREAD(10616)] [CTclExecutor::exec_file()] Tcl script file :C:/Program Files/iMC/server/bin/../../server/conf/adapters/ICC/Dell/DellPowerSwitch1524/cleanup.tcl don't exist.
    2022-08-11 14:12:28.361 [ERROR (9)] [THREAD(10616)] [CCLIScriptProcessor::login()] Fail to call m_poTclExecutor->execFile().AdaptName=DellPowerSwitch1524.DevIP =172.20.45.34.function script name = cleanup.tcl.
    2022-08-11 14:12:28.361 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,58054
    2022-08-11 14:12:28.361 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,52188
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,52264
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,54013
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,56542
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,64450
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,59436
    2022-08-11 14:12:28.362 [DEBUG (0)] [THREAD(10616)] [CQvSnmpEnv::getRandNumber] snmp udp-socket,62573
    2022-08-11 14:12:28.366 [WARNING (102)] [THREAD(10616)] [qvdm::getSnmpEngineIdFromConf] Fail to get item[engine_id] in file[C:\Program Files\iMC\server\bin\..\..\server\conf\engineID.conf].
    2022-08-11 14:12:28.718 [ERROR (7)] [THREAD(10616)] [CCLIScriptProcessor::exec_step()] Fail to call login().AdaptName=DellPowerSwitch1524,ServiceName=ConfigBackup,RequiredMode=enable
    2022-08-11 14:12:28.718 [INFO (7)] [THREAD(10616)] [CCLIScriptProcessor::exec_impl()] Fail to call exec_step(). AdaptName = DellPowerSwitch1524, ServiceName = ConfigBackup.
    2022-08-11 14:12:28.718 [ERROR (7)] [THREAD(10616)] [CCLIScriptProcessor::exec()] Fail to call exec_impl(). DevIP =172.20.45.34, AdaptName = DellPowerSwitch1524,service name = ConfigBackup, action name = backup_startup_config.
    2022-08-11 14:12:28.718 [DEBUG (0)] [THREAD(10616)] [ScriptTool::execScriptAction()] ResultNo: 7, CmdResp: , ResultMap:

    2022-08-11 14:12:29.735 [INFO (0)] [THREAD(12960)] [imcscriptttol] log: =============================== End===============================
    2022-08-11 14:12:29.735 [DEBUG (0)] [THREAD(12960)] [CScriptProcessor::exec()] Success to check result file. resp:

    and

    2022-08-11 14:12:30.740 [DEBUG (0)] [THREAD(13284)] [qvdm::writeOperLog] send operate log :{ -- SEQUENCE --
    strUserName '6163726f6f61646d'H -- "%username%" --,
    strOperTime ''H -- "" --,
    strIpAddr '3139322e3136382e342e313834'H -- "192.168.4.184" --,
    iModuleID '09'H --
    ,
    strOperDesc '4261636b75702072756e6e696e6720636f6e66696775726174696f6e2066696c653a2053573134312d3231283137322e32302e34352e3334292e'H -- "Backup.running.configuration.file:.SW141-21(172.20.45.34)." --,
    operRst '01'H --
    ,
    strOperFailReason '5472616e736665722066696c65203a205353482061757468656e74696361746564206661696c65642e'H -- "Transfer.file.:.SSH.authenticated.failed." --
    }

    2022-08-11 14:12:30.742 [DEBUG (0)] [THREAD(13284)] [iMCKeyGenerator:: getUnallocatedNextKey()] table: tbl_cfgbak_history_dev, field: tbl_id, key: 220865
    2022-08-11 14:12:30.744 [DEBUG (0)] [THREAD(13284)] [qvdm::writeOperLog] send operate log :{ -- SEQUENCE --
    strUserName '6163726f6f61646d'H -- "%username%" --,
    strOperTime ''H -- "" --,
    strIpAddr '3139322e3136382e342e313834'H -- "192.168.4.184" --,
    iModuleID '09'H --
    ,
    strOperDesc '4261636b7570207374617274757020636f6e66696775726174696f6e2066696c653a2053573134312d3231283137322e32302e34352e3334292e'H -- "Backup.startup.configuration.file:.SW141-21(172.20.45.34)." --,
    operRst '01'H --
    ,
    strOperFailReason '5472616e736665722066696c65203a205353482061757468656e74696361746564206661696c65642e'H -- "Transfer.file.:.SSH.authenticated.failed." --
    }

    2022-08-11 14:12:30.745 [DEBUG (0)] [THREAD(13284)] [iMCKeyGenerator:: getUnallocatedNextKey()] table: tbl_cfgbak_history_dev, field: tbl_id, key: 220866
    2022-08-11 14:12:31.748 [DEBUG (0)] [THREAD(13284)] [CCfgFileRestoreTask::sendBackupDevTaskNotify()]strRespondResult is


    2022-08-11 14:12:31.748 [DEBUG (0)] [THREAD(13284)] [CCfgFileRestoreTask::sendBackupDevTaskNotify()] Running File:redo_flag = 0, new_step = 1,finish_ flag = 1, notify = { -- SEQUENCE --
    iSessionID '060a'H --
    ,
    iJobID '060a'H --
    ,
    iDevID '0162'H --
    ,
    iExtendStatus '0e'H --
    ,
    iResultCode '03'H --
    ,
    iExtendResultCode '17e8'H --
    ,
    strExtendResult '3081e430090a01ff0a0217e8040002020162040431353436041653573134312d3231283137322e32302e34352e3334293081b43058300d300b0a01000a0217e804020d0a0a010002030155ed041672756e6e696e675f333731373239373536322e63666704273137322e32302e34352e33345f72756e6e696e675f32303232303831313134313232352e6366673058300d300b0a01000a0217e804020d0a0a010102030155ee0416737461727475705f333731373239373539322e63666704273137322e32302e34352e33345f737461727475705f32303232303831313134313232382e636667'H -- "0..0.............b..1546..SW141-21(172.20.45.34)0..0X0.0..................U...running_3717297562.cfg.'172.20.45.34_running_20220811141225.cfg0X0.0..................U...startup_3717297592.cfg.'172.20.45.34_startup_20220811141228.cfg" --,
    bFinished FALSE,
    iStepID '39'H --
    ,
    iFileType '00'H --
    ,
    bStepFinished TRUE,
    strRespondResult '0d0a'H -- ".." --
    }

    Does someone know how to fix this issue?

    Best regards


  • 2.  RE: iMC Backup failed - SSH Failure

    Posted Aug 12, 2022 04:20 AM
    Hi Aaron,

    Have you checked the config that sftp server enable is configured. Also, check the file transfer mode is correct and  has not changed (Service then options) 
    There are issues with PSFTP on P11 latest version of IMC. Particularly when upgrading an old version of switch. But check above first and also syncronize the switch again.

    Regards