C:\Program Files\Veritas\NetBackup\bin>vxlogview -p 51216 -t 00:05:00 2/7/2023 14:28:55.706 [MediaPerformanceTimer::handle_timeout] rank sent: 3 2/7/2023 14:28:55.706 [MediaPerformanceEventManager::sendEvents] state = 3 2/7/2023 14:28:55.706 [MediaPerformanceEventManager::sendToEventManager] state = 3 2/7/2023 14:29:10.586 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:29:17.831 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:29:17.831 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:29:17.831 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:29:17.831 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature Config_Webapp_Sig 2/7/2023 14:29:17.831 [MachineImpl::QueryMachinesWithFilter] MachineName <>, MachineNbuType <0>, MachineFlags <-1>, QueryType < (19) CEMM_MACHINE_QUERY_ALL_NBWSS_ENDPOINTS > 2/7/2023 14:29:17.831 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:29:45.722 [MediaPerformanceTimer::calculateStateChange] : load_avg_short=0.5, load_avg_long=0.333333, avg_freemem_short=5.37629e+006, avg_freemem_long=5.44816e+006 2/7/2023 14:29:45.722 [MediaPerformanceTimer::calculateStateChange] short_state=3, long_state=3, m_state= 3 2/7/2023 14:29:52.361 [DefaultQueue::queueRequest] queueing RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1384) 2/7/2023 14:29:52.361 [DefaultQueue::handle_input] sending RB getBirthTime : (CallbackQueue.cpp:1510) 2/7/2023 14:29:52.361 [DefaultQueue::delayedRequest] delaying RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1341) 2/7/2023 14:29:52.361 [DefaultQueue::handle_input] (0000000002C76650) CallbackQueue now empty(CallbackQueue.cpp:1594) 2/7/2023 14:30:10.218 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:30:11.226 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:30:17.930 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:17.930 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:17.930 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:17.930 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature Config_Webapp_Sig 2/7/2023 14:30:17.930 [MachineImpl::QueryMachinesWithFilter] MachineName <>, MachineNbuType <0>, MachineFlags <-1>, QueryType < (19) CEMM_MACHINE_QUERY_ALL_NBWSS_ENDPOINTS > 2/7/2023 14:30:17.930 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:30:34.191 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:34.191 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:34.191 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:34.191 V-111-1061 [NdmpImpl::queryNdmpFilerInfoByCredentialType] Client signature HOST= VER=<810000> APP= PID=<7440> 2/7/2023 14:30:34.191 [NdmpImpl::queryNdmpFilerInfoByCredentialType] retval - <0> 2/7/2023 14:30:34.191 V-111-1061 [NdmpResultSetImpl::NdmpInfoFetch] Client signature HOST= VER=<810000> APP= PID=<7440> 2/7/2023 14:30:34.222 [NdmpImpl::~NdmpImpl()] Exiting 2/7/2023 14:30:34.222 [NdmpResultSetImpl::NdmpInfoFetch] retval - <0> 2/7/2023 14:30:34.222 V-111-1061 [NdmpResultSetImpl::NdmpInfoFetch] Client signature HOST= VER=<810000> APP= PID=<7440> 2/7/2023 14:30:34.222 V-111-1062 [NdmpResultSetImpl::NdmpInfoFetch] retval 2007031 2/7/2023 14:30:34.222 V-111-1061 [NdmpImpl::ReleaseResultSet] Client signature HOST= VER=<810000> APP= PID=<7440> 2/7/2023 14:30:34.222 [NdmpImpl::ReleaseResultSet] retval - <0> 2/7/2023 14:30:34.285 [who] errorDomain=RDSM errorCode=2055003 errorText=checkLicense 2/7/2023 14:30:34.285 [Critical] V-178-9 DSM license check on windows failed 2/7/2023 14:30:34.285 V-137-311 [LicenseCheck::isFeatureLicensed] Feature id: 77 is not licensed 2/7/2023 14:30:34.285 [Error] V-230-20 RDSM has encountered an error: checkLicense():2572 2/7/2023 14:30:34.285 [Error] V-230-1 RDSM has encountered a service exception: Error Location: checkLicense():2572, Error Text: checkLicense, Error Domain: 3, Error Code 2055003 2/7/2023 14:30:34.317 [who] errorDomain=RDSM errorCode=2055003 errorText=checkLicense 2/7/2023 14:30:34.317 [Critical] V-178-9 DSM license check on windows failed 2/7/2023 14:30:34.317 V-137-311 [LicenseCheck::isFeatureLicensed] Feature id: 77 is not licensed 2/7/2023 14:30:34.317 [Error] V-230-20 RDSM has encountered an error: checkLicense():2572 2/7/2023 14:30:34.317 [Error] V-230-1 RDSM has encountered a service exception: Error Location: checkLicense():2572, Error Text: checkLicense, Error Domain: 3, Error Code 2055003 2/7/2023 14:30:34.332 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:34.332 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:34.332 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:34.332 V-111-1061 [MachineImpl::QueryMachine] Client signature HOST= VER=<810000> APP= PID=<7440> 2/7/2023 14:30:34.332 [MachineImpl::QueryMachine] - MachineName = windows MachineNbuType = 2 2/7/2023 14:30:34.332 [MachineImpl::QueryMachine] retval - <0> 2/7/2023 14:30:45.702 [MediaPerformanceTimer::calculateStateChange] : load_avg_short=0.5, load_avg_long=0.366667, avg_freemem_short=5.36959e+006, avg_freemem_long=5.44177e+006 2/7/2023 14:30:45.702 [MediaPerformanceTimer::calculateStateChange] short_state=3, long_state=3, m_state= 3 2/7/2023 14:30:56.005 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:56.005 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:56.005 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:56.005 V-111-1061 [NdmpImpl::queryNdmpCredentials] Client signature HOST= VER=<810000> APP= PID=<5608> 2/7/2023 14:30:56.020 [NdmpImpl::queryNdmpCredentials] retval - <0> 2/7/2023 14:30:56.020 V-111-1061 [NdmpImpl::deleteNdmpCredentials] Client signature HOST= VER=<810000> APP= PID=<5608> 2/7/2023 14:30:56.034 [NdmpImpl::deleteNdmpCredentials] retval - <0> 2/7/2023 14:30:56.034 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:56.034 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:56.034 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:56.034 V-111-1061 [MachineImpl::QueryMachine] Client signature HOST= VER=<810000> APP= PID=<5608> 2/7/2023 14:30:56.034 [MachineImpl::QueryMachine] - MachineName = windows MachineNbuType = 2 2/7/2023 14:30:56.034 [MachineImpl::QueryMachine] retval - <0> 2/7/2023 14:30:56.034 V-111-1061 [MachineImpl::UpdateMachine] Client signature HOST= VER=<810000> APP= PID=<5608> 2/7/2023 14:30:56.034 [MachineImpl::UpdateMachine] MachineExt_Record => { MachineName => windows MachineNbuType => 2 MachineFlags => 2 MachineDescription => NearStore } 2/7/2023 14:30:56.034 [MachineImpl::UpdateMachine] retval - <0> 2/7/2023 14:30:58.363 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:30:58.363 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:30:58.363 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:30:58.363 V-111-1061 [NdmpImpl::queryNdmpFilerInfoByCredentialType] Client signature HOST= VER=<810000> APP= PID=<7916> 2/7/2023 14:30:58.363 [NdmpImpl::queryNdmpFilerInfoByCredentialType] retval - <0> 2/7/2023 14:30:58.363 V-111-1061 [NdmpResultSetImpl::NdmpInfoFetch] Client signature HOST= VER=<810000> APP= PID=<7916> 2/7/2023 14:30:58.378 [NdmpImpl::~NdmpImpl()] Exiting 2/7/2023 14:30:58.378 [NdmpResultSetImpl::NdmpInfoFetch] retval - <0> 2/7/2023 14:30:58.378 V-111-1061 [NdmpResultSetImpl::NdmpInfoFetch] Client signature HOST= VER=<810000> APP= PID=<7916> 2/7/2023 14:30:58.378 V-111-1062 [NdmpResultSetImpl::NdmpInfoFetch] retval 2007031 2/7/2023 14:30:58.378 V-111-1061 [NdmpImpl::ReleaseResultSet] Client signature HOST= VER=<810000> APP= PID=<7916> 2/7/2023 14:30:58.378 [NdmpImpl::ReleaseResultSet] retval - <0> 2/7/2023 14:31:06.087 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature HOST= VER=<810000> APP= PID=<7108> 2/7/2023 14:31:06.087 [MachineImpl::QueryMachinesWithFilter] MachineName , MachineNbuType <3>, MachineFlags <0>, QueryType < (4) CEMM_MACHINE_QUERY_NB_SERVERS_WITH_VERSION_FILTER > 2/7/2023 14:31:06.087 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] Master server name : windows(ServiceInfoCollector.cpp:948) 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] Host Name: windows(ServiceInfoCollector.cpp:956) 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] Cluster Name: (ServiceInfoCollector.cpp:957) 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] ActiveNodeName: (ServiceInfoCollector.cpp:958) 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] Media server found : windows(ServiceInfoCollector.cpp:967) 2/7/2023 14:31:06.097 [ServiceInfoCollector::updateVersionInfo ] Media server version : 812000(ServiceInfoCollector.cpp:968) 2/7/2023 14:31:06.097 [isHostSame] Hostnames differences windows and windows hosts_equal Result = 1 found1 1 found 2 1(Utils.cpp:1439) 2/7/2023 14:31:06.097 [ServiceManagerExCollector::reBootstrapMediaServer] reBootstrapMediaServer requested Media Server : windows Action : 2 Old version : 0 New version : 0(ServiceManagerExCollector.cpp:429) 2/7/2023 14:31:10.883 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:31:17.988 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:31:17.988 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:31:17.988 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:31:18.005 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature Config_Webapp_Sig 2/7/2023 14:31:18.005 [MachineImpl::QueryMachinesWithFilter] MachineName <>, MachineNbuType <0>, MachineFlags <-1>, QueryType < (19) CEMM_MACHINE_QUERY_ALL_NBWSS_ENDPOINTS > 2/7/2023 14:31:18.005 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:31:27.535 [EventManager::handle_timeout] Reference count is 3(EventManager.cpp:448) 2/7/2023 14:31:33.691 V-137-311 [LicenseCheck::isFeatureLicensed] Feature id: 77 is not licensed 2/7/2023 14:31:33.691 [Error] V-230-20 RDSM has encountered an error: checkLicense():2572 2/7/2023 14:31:33.691 [Error] V-230-1 RDSM has encountered a service exception: Error Location: checkLicense():2572, Error Text: checkLicense, Error Domain: 3, Error Code 2055003 2/7/2023 14:31:33.707 [who] errorDomain=RDSM errorCode=2055003 errorText=checkLicense 2/7/2023 14:31:33.707 [Critical] V-178-9 DSM license check on windows failed 2/7/2023 14:31:33.769 [TlsProxy::initConnection] Tls proxy request from: 0000000003410F40 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:31:33.769 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:31:33.769 [DiskServiceQueryFacetImpl::getOpenStorageServersList()#5] No of storage servers returned from DSM::2(DiskServiceQueryFacetImpl.cpp:411) 2/7/2023 14:31:33.769 [DiskServiceQueryFacetImpl::getOpenStorageServersList()#5] No of open storage servers found::0(DiskServiceQueryFacetImpl.cpp:435) 2/7/2023 14:31:33.785 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:31:33.849 [ReadTask::runTask] Connection has been closed by peer on handle: 0000000000000490 (../LibNbPxyTasks.cpp:952) 2/7/2023 14:31:33.849 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 00000000034046B0 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:31:33.849 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 0000000000000490 Write Task Handle:000000000000046C terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:31:33.849 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:31:33.849 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:31:33.849 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:31:33.901 [CloudQFImpl::getMSNbcsscReponse()] Returning from getMSNbsccsResponse(CloudQFImpl.cpp:991) 2/7/2023 14:31:35.613 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:31:35.613 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:31:35.613 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:31:35.613 V-111-1061 [MachineImpl::ListMachines] Client signature HOST= VER=<810000> APP= PID=<7860> 2/7/2023 14:31:35.613 [MachineImpl::ListMachines] Master 2/7/2023 14:31:35.613 [MachineImpl::ListMachines] retval - <0> 2/7/2023 14:31:35.613 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature HOST= VER=<810000> APP= PID=<7860> 2/7/2023 14:31:35.613 [MachineImpl::QueryMachinesWithFilter] MachineName , MachineNbuType <3>, MachineFlags <-1>, QueryType < (16) CEMM_MACHINE_QUERY_ALL_NDMP_IN_DOMAIN > 2/7/2023 14:31:35.628 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:31:45.707 [MediaPerformanceTimer::calculateStateChange] : load_avg_short=0, load_avg_long=0.366667, avg_freemem_short=5.38832e+006, avg_freemem_long=5.44274e+006 2/7/2023 14:31:45.707 [MediaPerformanceTimer::calculateStateChange] short_state=3, long_state=3, m_state= 3 2/7/2023 14:31:49.363 V-111-1061 [DeviceConfigImpl::getRBCacheDriveList] Client signature Host= APP= PID=<2448> 2/7/2023 14:31:49.363 V-118-104 [ResBroker_i::doEvaluation] Evaluation cycle started 2/7/2023 14:31:49.381 [DeviceConfigImpl::getRBCacheDriveList] MasterServer 2/7/2023 14:31:49.394 [DeviceConfigImpl::getRBCacheDriveList] retval - <0> 2/7/2023 14:31:49.394 V-111-1061 [StorageUnitImpl_2::ListRBCacheStorageUnits] Client signature Host= APP= PID=<2448> 2/7/2023 14:31:49.394 [StorageUnitImpl_2::ListRBCacheStorageUnits] Master = windows 2/7/2023 14:31:49.410 [StorageUnitImpl_2::ListRBCacheStorageUnits] retval - <0> 2/7/2023 14:31:49.410 V-111-1061 [StorageUnitImpl_2::ListRBCacheStorageUnitGroups] Client signature Host= APP= PID=<2448> 2/7/2023 14:31:49.410 [StorageUnitImpl_2::ListRBCacheStorageUnitGroups] Master = windows 2/7/2023 14:31:49.410 [StorageUnitImpl_2::ListRBCacheStorageUnitGroups] retval - <0> 2/7/2023 14:31:49.410 V-111-1061 [MachineImpl::QueryMachine] Client signature Host= APP= PID=<2448> 2/7/2023 14:31:49.410 [MachineImpl::QueryMachine] - MachineName = windows MachineNbuType = 6 2/7/2023 14:31:49.410 [MachineImpl::QueryMachine] retval - <0> 2/7/2023 14:31:49.425 V-118-105 [ResBroker_i::doEvaluation] Resource evaluation started 2/7/2023 14:31:49.425 V-118-106 [ResBroker_i::doEvaluation] Resource evaluation completed. Evaluated 0 requests, sent resource pending for 0 requests, evaluation time 0 msec 2/7/2023 14:31:49.425 [ResBroker_i::doEvaluation] Evaluated 0 requests, evalTime=0 msec, numSucceeded=0, numQueued=0, numPended=0, numFailed=0, numMultipleCopyJobs=0, numMdsCacheMisses=0, restartedEvalCycle=0, numDriveReleasesBeforeEval=0, numDrivesAvailStart=0, numDrivesAvailEnd=0, requestQueueSize=0 2/7/2023 14:31:50.332 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:50.441 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:52.374 [DefaultQueue::queueRequest] queueing RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1384) 2/7/2023 14:31:52.383 [DefaultQueue::handle_input] sending RB getBirthTime : (CallbackQueue.cpp:1510) 2/7/2023 14:31:52.383 [DefaultQueue::delayedRequest] delaying RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1341) 2/7/2023 14:31:52.383 [DefaultQueue::handle_input] (0000000002C76650) CallbackQueue now empty(CallbackQueue.cpp:1594) 2/7/2023 14:31:52.604 [isSlpImportConfirmationEnabled] No entry for SLP.ENABLE_IMPORT_CONFIRMATION found, not enabled 2/7/2023 14:31:53.677 [EventSupplierTask::EventSupplierTask#5] EventSupplierTask constructed(EventSupplierTask.cpp:48) 2/7/2023 14:31:53.677 [EventSupplierTask::initialize#5] Event supplier task initialized(EventSupplierTask.cpp:169) 2/7/2023 14:31:53.677 [EventSupplier::EventSupplier] Event supplier constructed(EventSupplier.cpp:38) 2/7/2023 14:31:53.677 [EventDispatcher::initialize] EventDispatcher initialized(EventDispatcher.cpp:63) 2/7/2023 14:31:53.677 [EventSupplier::EventSupplier] Event dispatcher constructed(EventSupplier.cpp:41) 2/7/2023 14:31:53.677 [ClientManagerImpl::ClientManagerImpl()#5] Constructing ClientManagerImpl(ClientManagerImpl.cpp:35) 2/7/2023 14:31:53.677 [MgrUtils_T::execute] ClientManager IOR: IOR:010000003700000049444c3a53796d616e7465632f4e65744261636b75702f534c2f436c69656e744d676d742f436c69656e744d616e616765723a312e300000010000000149434f90000000010102320800000077696e646f77730014062b33050000006e62736c000000001b00000014010f005253543befe16314d000000c00000003000000300000000003000000000000000800000001000000004f4154010000001400000001000000010001050000000009010100000000000049434f180000000100a700860000000c0000006e62736c5f73656373766300(d:\nb\8.1.2\src\nb\nbsl\server\main\MgrUtils_T.cpp:73) 2/7/2023 14:31:53.832 [logconnections] BPCD CONNECT FROM 192.168.1.100.51052 TO 192.168.1.100.13782 fd = 2816 2/7/2023 14:31:53.879 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:53.879 [bpcr_get_platform_rqst] Server platform length = 7 2/7/2023 14:31:53.879 [logconnections] BPCD CONNECT FROM 192.168.1.100.51054 TO 192.168.1.100.13782 fd = 2848 2/7/2023 14:31:53.973 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:53.973 [bpcr_get_platform_rqst] Server platform length = 7 2/7/2023 14:31:53.973 [isClientWindows()] Hostname: windows, client_platform : win_x64, isWindows: true(Utils.cpp:992) 2/7/2023 14:31:53.973 [ClientQueryFacetImpl::getClientHWOS#5] Hostname: windows, client_platform : win_x64, hardware : PC-x64, os : WindowsXP, sysName :(ClientQueryFacetImpl.cpp:162) 2/7/2023 14:31:53.973 [EventSupplierTask::EventSupplierTask#5] EventSupplierTask constructed(EventSupplierTask.cpp:48) 2/7/2023 14:31:53.973 [EventSupplierTask::initialize#5] Event supplier task initialized(EventSupplierTask.cpp:169) 2/7/2023 14:31:53.973 [EventSupplier::EventSupplier] Event supplier constructed(EventSupplier.cpp:38) 2/7/2023 14:31:53.973 [EventDispatcher::initialize] EventDispatcher initialized(EventDispatcher.cpp:63) 2/7/2023 14:31:53.973 [EventSupplier::EventSupplier] Event dispatcher constructed(EventSupplier.cpp:41) 2/7/2023 14:31:53.973 [MgrUtils_T::execute] DBRestoreManager IOR: IOR:010000003c00000049444c3a53796d616e7465632f4e65744261636b75702f534c2f5265636f766572794d676d742f4442526573746f72654d616e616765723a312e3000010000000149434f90000000010102000800000077696e646f77730014066574050000006e62736c002f44691b00000014010f005253543befe16314d00000150000000100000032000000000300000000000000080000000122616c004f4154010000001400000001494f50010001050000000009010100000000000049434f180000000122a700860041540c0000006e62736c5f73656373766300(d:\nb\8.1.2\src\nb\nbsl\server\main\MgrUtils_T.cpp:73) 2/7/2023 14:31:53.973 [DBRestoreManagerImpl::aqueryFacet()#5] Getting the OracleDBRestoreQueryFacetImpl(DBRestoreManagerImpl.cpp:158) 2/7/2023 14:31:53.973 [ApplicationsUtil::ApplicationsUtil] Constructed ApplicationsUtil(ApplicationsUtil.cpp:34) 2/7/2023 14:31:54.055 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:54.067 [logconnections] BPCD CONNECT FROM 192.168.1.100.51056 TO 192.168.1.100.13782 fd = 2840 2/7/2023 14:31:54.128 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:54.128 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:54.992 [DBRestoreManagerImpl::aqueryFacet()#5] Getting the OracleDBRestoreQueryFacetImpl(DBRestoreManagerImpl.cpp:158) 2/7/2023 14:31:55.083 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:55.083 [logconnections] BPCD CONNECT FROM 192.168.1.100.51058 TO 192.168.1.100.13782 fd = 940 2/7/2023 14:31:55.144 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:55.144 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:57.160 [DBRestoreManagerImpl::aqueryFacet()#5] Getting the OracleDBRestoreQueryFacetImpl(DBRestoreManagerImpl.cpp:158) 2/7/2023 14:31:57.238 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:57.256 [logconnections] BPCD CONNECT FROM 192.168.1.100.51060 TO 192.168.1.100.13782 fd = 3064 2/7/2023 14:31:57.302 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:57.302 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:57.519 [DBRestoreManagerImpl::aqueryFacet()#5] Getting the OracleDBRestoreQueryFacetImpl(DBRestoreManagerImpl.cpp:158) 2/7/2023 14:31:57.550 [ConfigurationProviderHolder::setConfigurationProvider] Using configuration provider default configuration using bpconf_api with registry lookup (../ConfigurationProvider.cpp:65) 2/7/2023 14:31:57.581 [logconnections] BPCD CONNECT FROM 192.168.1.100.51062 TO 192.168.1.100.13782 fd = 3060 2/7/2023 14:31:57.631 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:57.631 [bpcr_get_version_rqst] bpcd version: 08100000 2/7/2023 14:31:57.764 [retry_getaddrinfo_for_real] [vnet_addrinfo.c:1133] getaddrinfo() failed RV=11001 NAME=WINDOWS1 SVC=0 2/7/2023 14:31:57.764 [retry_getaddrinfo] [vnet_addrinfo.c:968] retry_getaddrinfo_for_real failed RV=11001 NAME=WINDOWS1 SVC=0 2/7/2023 14:31:57.764 [vnet_cached_getaddrinfo_and_update] [vnet_addrinfo.c:1792] retry_getaddrinfo() failed RV=11001 NAME=WINDOWS1 SVC=NULL 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo] [vnet_addrinfo.c:1420] vnet_cached_getaddrinfo_and_update() failed 6 0x6 2/7/2023 14:31:57.773 [vnet_is_local_host] [vnet_addrinfo.c:347] vnet_cached_getaddrinfo() failed STAT=6 RV=11001 NAME=WINDOWS1 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo_and_update] [vnet_addrinfo.c:1697] in failed cache ERR=11001 NAME=WINDOWS1 SVC=NULL 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo] [vnet_addrinfo.c:1420] vnet_cached_getaddrinfo_and_update() failed 6 0x6 2/7/2023 14:31:57.773 [vnet_same_host_and_update] [vnet_addrinfo.c:3095] vnet_cached_getaddrinfo() failed STAT=6 RV=11001 NAME1=WINDOWS1 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo_and_update] [vnet_addrinfo.c:1697] in failed cache ERR=11001 NAME=WINDOWS1 SVC=NULL 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo] [vnet_addrinfo.c:1420] vnet_cached_getaddrinfo_and_update() failed 6 0x6 2/7/2023 14:31:57.773 [vnet_is_local_host] [vnet_addrinfo.c:347] vnet_cached_getaddrinfo() failed STAT=6 RV=11001 NAME=WINDOWS1 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo_and_update] [vnet_addrinfo.c:1697] in failed cache ERR=11001 NAME=WINDOWS1 SVC=NULL 2/7/2023 14:31:57.773 [vnet_cached_getaddrinfo] [vnet_addrinfo.c:1420] vnet_cached_getaddrinfo_and_update() failed 6 0x6 2/7/2023 14:31:57.773 [init_connect_recs] [vnet_connect.c:1100] vnet_cached_getaddrinfo() failed STAT=6 RV=11001 HOST=WINDOWS1 2/7/2023 14:31:57.773 [connect_to_service] [vnet_connect.c:883] init_connect_recs() failed 6 0x6 2/7/2023 14:31:57.773 [connect_to_service] JSON data = {"allow_large_status": {"timestamp": 1675762315, "who": "vnet_tss_init", "line_number": 32, "comment": "allow vnet status > 255", "data": false}, "direct_connect": {"timestamp": 1675762315, "who": "connect_to_service", "line_number": 838, "comment": "connect parameters", "data": {"who": "vnet_connect_to_vnetd_ipi", "host": "WINDOWS1", "service": "vnetd", "override_required_interface": null, "extra_tries_on_connect": 0, "getsock_disable_to": 0, "overide_connect_timeout": 0, "connect_options": null}}, "status": {"timestamp": 1675762317, "who": "connect_to_service", "line_number": 985, "comment": "vnet status", "data": 6}} 2/7/2023 14:31:57.773 [vnet_connect_to_vnetd_ipi] [vnet_connect.c:467] connect_to_service() failed 6 0x6 2/7/2023 14:31:57.773 [vnet_get_host_version_ipi] [vnet_vnetd.c:2537] vnet_connect_to_vnetd_ipi() failed, status=6, host=WINDOWS1 2/7/2023 14:31:57.773 [RemoteMasters::getRemoteMasterInfo] (00000000039DCB70)failed to get remote master version for host 'WINDOWS1', status= 6(NbuDataMgr.cpp:301) 2/7/2023 14:31:57.802 [ConnectionCache::connectAndCache] Acquiring new connection for host windows, query type 91 2/7/2023 14:31:57.816 [logconnections] BPDBM CONNECT FROM 192.168.1.100.51064 TO 192.168.1.100.13721 fd = 2936 2/7/2023 14:31:57.879 [db_sendSTATUS] Status:0 2/7/2023 14:31:57.879 [db_end] Need to collect reply 2/7/2023 14:31:57.910 [ConnectionCache::connectAndCache] Acquiring new connection for host windows, query type 91 2/7/2023 14:31:57.910 [logconnections] BPDBM CONNECT FROM 192.168.1.100.51065 TO 192.168.1.100.13721 fd = 2936 2/7/2023 14:31:57.974 [db_sendSTATUS] Status:0 2/7/2023 14:31:57.974 [db_end] Need to collect reply 2/7/2023 14:32:06.738 [DiskServiceModifiableFacetImpl::DiskServiceModifiableFacetImpl()#5] Constructing(DiskServiceModifiableFacetImpl.cpp:47) 2/7/2023 14:32:06.769 V-111-1061 [MachineImpl::CreateMachine] Client signature HOST= VER=<810000> APP= PID=<7108> 2/7/2023 14:32:06.769 [MachineImpl::CreateMachine] MachineExt_Record => { MachineName => windows MachineNbuType => 2 MachineFlags => 2 } 2/7/2023 14:32:06.769 V-111-1062 [MachineImpl::CreateMachine] retval 2001046 2/7/2023 14:32:06.769 [DiskServiceModifiableFacetImpl::createStorageServer#5] storageType passed as default:-1, changing to proper value(DiskServiceModifiableFacetImpl.cpp:846) 2/7/2023 14:32:06.769 [DiskServiceModifiableFacetImpl::createStorageServer#5] storageServer:windows, storageServerType:PureDisk, NEW_storageType:9, connectMediaServer:windows(DiskServiceModifiableFacetImpl.cpp:868) 2/7/2023 14:32:06.785 [MachineConfigImpl::~MachineConfigImpl()] Exiting 2/7/2023 14:32:06.800 [StorageServerObject_i::server_init] stsName: PureDisk:windows 2/7/2023 14:32:06.800 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:06.800 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:06.816 [MachineConfigImpl::~MachineConfigImpl()] Exiting 2/7/2023 14:32:06.832 [PerformAudit] Need to persist 1 audit record(s)(AdTrDbWrap.cpp:625) 2/7/2023 14:32:06.832 [get_user_identity_A] Using local Admin creds(user_identity.cpp:259) 2/7/2023 14:32:06.847 V-293-9 [PerformAudit] Action audited: Storage Server 'windows' of type 'PureDisk' was created 2/7/2023 14:32:06.847 [PerformAudit] Persisted audit records: 1(AdTrDbWrap.cpp:671) 2/7/2023 14:32:06.847 [PerformAudit] Need to persist 1 audit record(s)(AdTrDbWrap.cpp:625) 2/7/2023 14:32:06.847 V-293-9 [PerformAudit] Action audited: Storage Server 'windows' of type 'PureDisk' was updated 2/7/2023 14:32:06.847 [DsmAudit] Audit Result: 0 2/7/2023 14:32:06.847 [get_user_identity_A] Using local Admin creds(user_identity.cpp:259) 2/7/2023 14:32:06.863 [PerformAudit] Persisted audit records: 1(AdTrDbWrap.cpp:671) 2/7/2023 14:32:06.863 [DsmAudit] Audit Result: 0 2/7/2023 14:32:06.863 [DiskServiceModifiableFacetImpl::createStorageServer#5] Created:windows(DiskServiceModifiableFacetImpl.cpp:892) 2/7/2023 14:32:06.900 [DiskServiceModifiableFacetImpl::addSTSCredential#5] Adding User:admin(DiskServiceModifiableFacetImpl.cpp:1250) 2/7/2023 14:32:06.900 [DiskServiceModifiableFacetImpl::addSTSCredential#5] storageServer:windows storageServerType:PureDisk userID:admin connectMediaServer:windows(DiskServiceModifiableFacetImpl.cpp:1438) 2/7/2023 14:32:06.900 [vnet_proxy_required_ex] ignoring proxy for non-NB service 49950 2/7/2023 14:32:06.950 [vnet_proxy_required_ex] ignoring proxy for non-NB service 49950 2/7/2023 14:32:06.957 [bpcompatd_log_sockinfo] bpcompatdreq.cpp.2698: BPCOMPATD CONNECT FROM 127.0.0.1.51068 TO 127.0.0.1.49950 fd = 2560 2/7/2023 14:32:06.972 [TpCommand::GetMessage()] Read 24 bytes from host < windows >(TpCommand.cpp:598) 2/7/2023 14:32:06.972 [TpCommand::GetMessage()] Read 13 bytes from host < windows >(TpCommand.cpp:598) 2/7/2023 14:32:07.050 [TpCommand::GetMessage()] Read 12 bytes from host < windows >(TpCommand.cpp:598) 2/7/2023 14:32:09.597 [StorageServerObject::getDataMovers] MasterServerKey = 0 Not Enabled 2/7/2023 14:32:09.597 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:32:09.597 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:32:09.597 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:32:09.613 V-111-1061 [NdmpImpl::createNdmpCredentials] Client signature HOST= VER=<810000> APP= PID=<7696> 2/7/2023 14:32:09.613 [NdmpImpl::helperCreateNdmpCredentials] (29.2423) stmt=(DbConnection.cpp:711) 2/7/2023 14:32:09.613 [NdmpImpl::createNdmpCredentials] retval - <0> 2/7/2023 14:32:09.630 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:32:09.630 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:32:09.630 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:32:09.630 V-111-1061 [MachineImpl::GetMachineAliasList] Client signature HOST= VER=<810000> APP= PID=<7696> 2/7/2023 14:32:09.630 [MachineImpl::GetMachineAliasList] - MachineName = windows MachineNbuType = 2 2/7/2023 14:32:09.630 [MachineImpl::GetMachineAliasList] retval - <0> 2/7/2023 14:32:09.630 V-111-1061 [MachineImpl::QueryMachine] Client signature HOST= VER=<810000> APP= PID=<7696> 2/7/2023 14:32:09.630 [MachineImpl::QueryMachine] - MachineName = windows MachineNbuType = 2 2/7/2023 14:32:09.630 [MachineImpl::QueryMachine] retval - <0> 2/7/2023 14:32:09.644 V-111-1061 [MachineImpl::UpdateMachine] Client signature HOST= VER=<810000> APP= PID=<7696> 2/7/2023 14:32:09.644 [MachineImpl::UpdateMachine] MachineExt_Record => { MachineName => windows MachineNbuType => 2 MachineFlags => 2 MachineDescription => PureDisk } 2/7/2023 14:32:09.644 [MachineImpl::UpdateMachine] retval - <0> 2/7/2023 14:32:09.644 [TpCommand::GetMessage()] Read 8 bytes from host < windows >(TpCommand.cpp:598) 2/7/2023 14:32:09.644 [TpCommand::GetMessage()] Read 13 bytes from host < windows >(TpCommand.cpp:598) 2/7/2023 14:32:09.644 [TpCommand::doTpconfig()] host < windows > returned status "0"(TpCommand.cpp:699) 2/7/2023 14:32:09.644 [TpCommand::compareStatusString()] host < windows > returned status "0"(TpCommand.cpp:730) 2/7/2023 14:32:09.709 [who] errorDomain=RDSM errorCode=2055003 errorText=checkLicense 2/7/2023 14:32:09.709 [Critical] V-178-9 DSM license check on windows failed 2/7/2023 14:32:09.709 V-137-311 [LicenseCheck::isFeatureLicensed] Feature id: 77 is not licensed 2/7/2023 14:32:09.709 [Error] V-230-20 RDSM has encountered an error: checkLicense():2572 2/7/2023 14:32:09.709 [Error] V-230-1 RDSM has encountered a service exception: Error Location: checkLicense():2572, Error Text: checkLicense, Error Domain: 3, Error Code 2055003 2/7/2023 14:32:09.723 [StorageServerObject::getDataMovers] MasterServerKey = 0 Not Enabled 2/7/2023 14:32:09.723 [StorageServerObject_i::server_init] stsName: PureDisk:windows 2/7/2023 14:32:09.723 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:09.723 [DiskServiceQueryFacetImpl::getOpenStorageServersList()#5] No of storage servers returned from DSM::3(DiskServiceQueryFacetImpl.cpp:411) 2/7/2023 14:32:09.723 [DiskServiceQueryFacetImpl::getOpenStorageServersList()#5] No of open storage servers found::1(DiskServiceQueryFacetImpl.cpp:435) 2/7/2023 14:32:09.738 V-111-1061 [NdmpImpl::queryNdmpCredentials] Client signature HOST= VER=<810000> APP= PID=<6320> 2/7/2023 14:32:09.754 [NdmpImpl::queryNdmpCredentials] retval - <0> 2/7/2023 14:32:09.786 [CloudQFImpl::getMSNbcsscReponse()] Returning from getMSNbsccsResponse(CloudQFImpl.cpp:991) 2/7/2023 14:32:10.510 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:32:11.535 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:32:12.054 [STS Service] [ERROR] PDVFS: pdvfs_register_create_ost_agent: _pdvfs_register_discover failed for spa_addr windows 2/7/2023 14:32:12.054 [STS Service] [ERROR] PDVFS: PdvfsRegisterOST: pdvfs_register_create_ost_agent failed: Unknown error (107) 2/7/2023 14:32:12.054 [STS Service] [ERROR] PDSTS: pd_register: PdvfsRegisterOST(windows) failed (107:Unknown error) 2/7/2023 14:32:12.054 [STS Service] [ERROR] PDSTS: get_agent_cfg_file_path_for_mount: pd_register() failed for configuration file: (2060023:server is shut down) 2/7/2023 14:32:12.054 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060023:server is shut down) 2/7/2023 14:32:12.054 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:12.113 [MachineConfigImpl::~MachineConfigImpl()] Exiting 2/7/2023 14:32:12.113 V-111-1061 [NdmpImpl::queryNdmpCredentials] Client signature HOST= VER=<810000> APP= PID=<6320> 2/7/2023 14:32:12.113 [StorageServerObject_i::server_init] stsName: PureDisk:windows 2/7/2023 14:32:12.113 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:12.129 [NdmpImpl::queryNdmpCredentials] retval - <0> 2/7/2023 14:32:14.270 [STS Service] [ERROR] PDVFS: pdvfs_register_create_ost_agent: _pdvfs_register_discover failed for spa_addr windows 2/7/2023 14:32:14.270 [STS Service] [ERROR] PDVFS: PdvfsRegisterOST: pdvfs_register_create_ost_agent failed: Unknown error (107) 2/7/2023 14:32:14.270 [STS Service] [ERROR] PDSTS: pd_register: PdvfsRegisterOST(windows) failed (107:Unknown error) 2/7/2023 14:32:14.270 [STS Service] [ERROR] PDSTS: get_agent_cfg_file_path_for_mount: pd_register() failed for configuration file: (2060023:server is shut down) 2/7/2023 14:32:14.270 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060023:server is shut down) 2/7/2023 14:32:14.285 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:32:18.113 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:32:18.113 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:32:18.113 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:32:18.113 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature Config_Webapp_Sig 2/7/2023 14:32:18.113 [MachineImpl::QueryMachinesWithFilter] MachineName <>, MachineNbuType <0>, MachineFlags <-1>, QueryType < (19) CEMM_MACHINE_QUERY_ALL_NBWSS_ENDPOINTS > 2/7/2023 14:32:18.113 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:32:19.646 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature HOST= VER=<810000> APP= PID=<7108> 2/7/2023 14:32:19.646 [MachineImpl::QueryMachinesWithFilter] MachineName , MachineNbuType <3>, MachineFlags <0>, QueryType < (4) CEMM_MACHINE_QUERY_NB_SERVERS_WITH_VERSION_FILTER > 2/7/2023 14:32:19.660 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] Master server name : windows(ServiceInfoCollector.cpp:948) 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] Host Name: windows(ServiceInfoCollector.cpp:956) 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] Cluster Name: (ServiceInfoCollector.cpp:957) 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] ActiveNodeName: (ServiceInfoCollector.cpp:958) 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] Media server found : windows(ServiceInfoCollector.cpp:967) 2/7/2023 14:32:19.660 [ServiceInfoCollector::updateVersionInfo ] Media server version : 812000(ServiceInfoCollector.cpp:968) 2/7/2023 14:32:19.660 [isHostSame] Hostnames differences windows and windows hosts_equal Result = 1 found1 1 found 2 1(Utils.cpp:1439) 2/7/2023 14:32:19.660 [ServiceManagerExCollector::reBootstrapMediaServer] reBootstrapMediaServer requested Media Server : windows Action : 2 Old version : 0 New version : 0(ServiceManagerExCollector.cpp:429) 2/7/2023 14:32:26.316 [TlsProxy::initConnection] Tls proxy request from: 00000000034106C0 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:26.316 [TlsProxy::initConnection] Tls proxy request from: 0000000003410F40 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:26.316 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.316 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.374 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.374 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.425 [ReadTask::runTask] Connection has been closed by peer on handle: 00000000000003F8 (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:26.425 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 00000000034095D0 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:26.425 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 00000000000003F8 Write Task Handle:0000000000000274 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:26.425 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:26.425 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.425 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:26.441 [ReadTask::runTask] Connection has been closed by peer on handle: 0000000000000484 (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:26.441 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 0000000003415310 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:26.441 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 0000000000000484 Write Task Handle:0000000000000470 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:26.441 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:26.441 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.441 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:26.739 [TlsProxy::initConnection] Tls proxy request from: 0000000003411200 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:26.739 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.739 [TlsProxy::initConnection] Tls proxy request from: 0000000003410A00 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:26.739 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.758 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.758 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.785 [ReadTask::runTask] Connection has been closed by peer on handle: 000000000000028C (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:26.785 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 0000000003409C90 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:26.785 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 000000000000028C Write Task Handle:0000000000000490 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:26.785 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:26.785 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.785 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:26.785 [ReadTask::runTask] Connection has been closed by peer on handle: 000000000000046C (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:26.785 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 000000000340CE80 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:26.785 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 000000000000046C Write Task Handle:0000000000000274 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:26.785 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:26.785 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:26.785 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:27.207 [TlsProxy::initConnection] Tls proxy request from: 0000000003410E00 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:27.207 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.207 [TlsProxy::initConnection] Tls proxy request from: 0000000003410B40 (../LibNbPxyTlsProxy.cpp:210) 2/7/2023 14:32:27.207 [TlsProxy::setState] [234] Transitioning state from: TLS_PROXY_IDLE to: TLS_PROXY_CONNECTOR (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.223 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.223 [TlsProxy::setState] [337] Transitioning state from: TLS_PROXY_CONNECTOR to: TLS_PROXY_RUNNER (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.269 [ReadTask::runTask] Connection has been closed by peer on handle: 00000000000003F8 (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:27.269 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 0000000003415600 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:27.269 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 00000000000003F8 Write Task Handle:0000000000000460 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:27.269 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:27.269 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.269 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:27.269 [ReadTask::runTask] Connection has been closed by peer on handle: 00000000000003E8 (../LibNbPxyTasks.cpp:952) 2/7/2023 14:32:27.269 [IoChannel::runTask] Set state to IOCHANNEL_SHUTDOWN on 00000000034095D0 (../machines/LibNbPxyRunner.cpp:263) 2/7/2023 14:32:27.269 [Runner::asyncIoTaskComplete] Async IO operation on IoChannel State: IOCHANNEL_SHUTDOWN Read Task Handle: 00000000000003E8 Write Task Handle:0000000000000430 terminated; Connection was closed by peer., nbu status = 7640, severity = 2 (../machines/LibNbPxyRunner.cpp:571) 2/7/2023 14:32:27.269 [AsyncIoTaskEngine::handle_input] Connection was closed by peer., nbu status = 7640, severity = 2 (../LibNbPxyAsyncIoTask.cpp:275) 2/7/2023 14:32:27.269 [TlsProxy::setState] [134] Transitioning state from: TLS_PROXY_RUNNER to: TLS_PROXY_COMPLETE (../LibNbPxyTlsProxy.cpp:403) 2/7/2023 14:32:27.269 [StateMachineEngine::transitionState] Info: State machine completed with status. (../LibNbPxyStateMachine.cpp:3632) 2/7/2023 14:32:45.707 [MediaPerformanceTimer::calculateStateChange] : load_avg_short=0, load_avg_long=0.366667, avg_freemem_short=5.33648e+006, avg_freemem_long=5.439e+006 2/7/2023 14:32:45.707 [MediaPerformanceTimer::calculateStateChange] short_state=3, long_state=3, m_state= 3 2/7/2023 14:33:11.129 V-219-1 [ResourceEventMgr_i::updateInfo ] Heartbeat received from host windows 2/7/2023 14:33:18.207 V-111-1061 [ServerImpl::GetInterfaceRef] Client signature none 2/7/2023 14:33:18.207 [ServerImpl::GetInterfaceRef] For version <1> 2/7/2023 14:33:18.207 [ServerImpl::GetInterfaceRef] retval - <0> 2/7/2023 14:33:18.223 V-111-1061 [MachineImpl::QueryMachinesWithFilter] Client signature Config_Webapp_Sig 2/7/2023 14:33:18.223 [MachineImpl::QueryMachinesWithFilter] MachineName <>, MachineNbuType <0>, MachineFlags <-1>, QueryType < (19) CEMM_MACHINE_QUERY_ALL_NBWSS_ENDPOINTS > 2/7/2023 14:33:18.223 [MachineImpl::QueryMachinesWithFilter] retval - <0> 2/7/2023 14:33:21.582 [STS Service] [ERROR] PDVFS: pdvfs_lib_log: Dedup server configuration failed. Please see the pdde-config.log for more information 2/7/2023 14:33:21.582 [STS Service] [ERROR] PDSTS: pd_set_config: PdvfsSetconfig() failed with <-1> (5:Input/output error) 2/7/2023 14:33:21.582 [STS Service] [ERROR] PDSTS: pi_ioctl_v9: pd_set_config() failed (2060017:system call failed) 2/7/2023 14:33:21.582 [StorageServerObject_i::updateServerConfig] sts_ioctl(STS_IOCTL_SANDISK_SET_STS_CONFIG) failed with code=2060017 2/7/2023 14:33:21.582 [StorageServerService_i::updateStorageServerConfig] Cannot update server config: 2/7/2023 14:33:21.582 [StorageServerService_i::updateStorageServerConfig] Sts error code = 2060017 2/7/2023 14:33:21.582 [Error] V-230-36 Reconfiguration failed for storage server updateStorageServerConfig():2504. system call failed 2/7/2023 14:33:21.582 [Error] V-230-1 RDSM has encountered a service exception: Error Location: updateStorageServerConfig():2504, Error Text: system call failed, Error Domain: 4, Error Code 2060017 2/7/2023 14:33:21.582 [DSMExceptionTranslator::getErrorDetails()] Exception name:ServiceException(DSMExceptionTranslator.cpp:46) 2/7/2023 14:33:21.582 [DSMExceptionTranslator::dsmServiceEx_str()] DSM exception details: Reconfiguration failed for storage server PureDisk:windows. system call failed(DSMExceptionTranslator.cpp:97) 2/7/2023 14:33:21.582 [EMMErrorTranslator::getErrorFromErrCode()] EMM error code: 2060017(EMMErrorTranslator.cpp:80) 2/7/2023 14:33:21.582 [EMMErrorTranslator::getErrorFromErrCode()] EMM error text: system call failed(EMMErrorTranslator.cpp:81) 2/7/2023 14:33:21.582 [NBUErrorTranslator::getErrorDetails()] NB error code: 11 NB localized Error text: system call failed(NBUErrorTranslator.cpp:47) 2/7/2023 14:33:21.582 [ExceptionManager::fillExceptionObject()] Error:DiskServiceModifiableFacetImpl::setStorageServerConfig#5:../DiskServiceModifiableFacetImpl.cpp(1395): errNo:11 localizedStr:system call failed additionalStr:Reconfiguration failed for storage server PureDisk:windows. system call failed(ExceptionManager.cpp:97) 2/7/2023 14:33:21.660 [DiskServiceModifiableFacetImpl::removeStorageServer#5] storageServer:windows, storageServerType:PureDisk(DiskServiceModifiableFacetImpl.cpp:1111) 2/7/2023 14:33:21.691 [MachineConfigImpl::~MachineConfigImpl()] Exiting 2/7/2023 14:33:21.707 [StorageServerObject_i::server_init] stsName: PureDisk:windows 2/7/2023 14:33:21.707 [STS Service] [WARN] PDSTS: get_agent_cfg_file_path_for_mount: cannot read PureDisk agent configuration file (2060018:file not found) 2/7/2023 14:33:21.738 [PerformAudit] Need to persist 1 audit record(s)(AdTrDbWrap.cpp:625) 2/7/2023 14:33:21.738 V-293-9 [PerformAudit] Action audited: Storage Server 'windows' of type 'PureDisk' was deleted 2/7/2023 14:33:21.738 [PerformAudit] Persisted audit records: 1(AdTrDbWrap.cpp:671) 2/7/2023 14:33:21.738 [get_user_identity_A] Using local Admin creds(user_identity.cpp:259) 2/7/2023 14:33:21.738 [DsmAudit] Audit Result: 0 2/7/2023 14:33:21.738 [DiskServiceModifiableFacetImpl::removeStorageServer#5] Deleted:windows(DiskServiceModifiableFacetImpl.cpp:1117) 2/7/2023 14:33:21.754 [who] errorDomain=RDSM errorCode=2055003 errorText=checkLicense 2/7/2023 14:33:21.754 [Critical] V-178-9 DSM license check on windows failed 2/7/2023 14:33:21.754 V-137-311 [LicenseCheck::isFeatureLicensed] Feature id: 77 is not licensed 2/7/2023 14:33:21.754 [Error] V-230-20 RDSM has encountered an error: checkLicense():2572 2/7/2023 14:33:21.754 [Error] V-230-1 RDSM has encountered a service exception: Error Location: checkLicense():2572, Error Text: checkLicense, Error Domain: 3, Error Code 2055003 2/7/2023 14:33:21.769 [DiskServiceModifiableFacetImpl::isStorageServerExist#5] No of storage servers returned from DSM::2(DiskServiceModifiableFacetImpl.cpp:1010) 2/7/2023 14:33:45.695 [MediaPerformanceTimer::calculateStateChange] : load_avg_short=0, load_avg_long=0.366667, avg_freemem_short=5.35546e+006, avg_freemem_long=5.4342e+006 2/7/2023 14:33:45.695 [MediaPerformanceTimer::calculateStateChange] short_state=3, long_state=3, m_state= 3 2/7/2023 14:33:52.392 [DefaultQueue::queueRequest] queueing RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1384) 2/7/2023 14:33:52.392 [DefaultQueue::handle_input] sending RB getBirthTime : (CallbackQueue.cpp:1510) 2/7/2023 14:33:52.394 [DefaultQueue::delayedRequest] delaying RB getBirthTime : -- retry count=-1(CallbackQueue.cpp:1341) 2/7/2023 14:33:52.394 [DefaultQueue::handle_input] (0000000002C76650) CallbackQueue now empty(CallbackQueue.cpp:1594)