Server Log Entry: CCopyManager?

Software-based VM-centric and flash-friendly VM storage + free version

Moderators: anton (staff), art (staff), Max (staff), Anatoly (staff)

Post Reply
AndrewBucklin
Posts: 4
Joined: Thu Jan 05, 2017 4:16 am

Wed Nov 29, 2017 4:36 am

On Node02, starting about 2 months ago, there is a message regarding CCopyManager multiple times per hour. What does this mean? Thank you!


Node01 Recent Log:
11/28 9:37:49.613 251c SCSI: CWriteUsingTokenOperation::InitializeAndValidate: The ROD token is expired!
11/28 9:37:49.613 251c HA: CHADevice::CompleteSscCommandRequest: (0x83) CHECK_CONDITION , sense: 0x5 0x17/0x7 returned.
11/28 9:37:49.613 251c SCSI: CReceiveRODTokenInfoOperation::Execute: Copy manager doesn't have operation with '0x25045' list identifier!
11/28 9:37:49.613 251c HA: CHADevice::CompleteSscCommandRequest: (0x84) CHECK_CONDITION , sense: 0x5 0x24/0x0 returned.
11/28 9:37:51.644 251c SCSI: CWriteUsingTokenOperation::InitializeAndValidate: The ROD token does not match any known to the copy manager!
11/28 9:37:51.644 251c HA: CHADevice::CompleteSscCommandRequest: (0x83) CHECK_CONDITION , sense: 0x5 0x17/0x4 returned.
11/28 9:37:51.644 251c SCSI: CReceiveRODTokenInfoOperation::Execute: Copy manager doesn't have operation with '0x2504d' list identifier!
11/28 9:37:51.644 251c HA: CHADevice::CompleteSscCommandRequest: (0x84) CHECK_CONDITION , sense: 0x5 0x24/0x0 returned.
11/28 9:37:51.644 251c SCSI: CWriteUsingTokenOperation::InitializeAndValidate: The ROD token does not match any known to the copy manager!
11/28 9:37:51.644 251c HA: CHADevice::CompleteSscCommandRequest: (0x83) CHECK_CONDITION , sense: 0x5 0x17/0x4 returned.
11/28 9:37:51.644 251c SCSI: CReceiveRODTokenInfoOperation::Execute: Copy manager doesn't have operation with '0x2504e' list identifier!
11/28 9:37:51.644 251c HA: CHADevice::CompleteSscCommandRequest: (0x84) CHECK_CONDITION , sense: 0x5 0x24/0x0 returned.
11/28 16:20:12.576 2a78 Sp: *** CStarPackPagePacker::GetDataHash Logical error. There is no entry [481589684] in the data list
11/28 16:20:12.576 2a78 Sp: *** CSiDedupeBase::AddHash The full hash verification routine has been failed! Status (4306)
11/28 22:15:07.737 868 Srv: *LICENSE* Revalidation - License OK.


Node02 Recent Log:
11/28 9:37:46.152 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2502e) corresponds to expired ROD(0x000002485FA52500) will be removed.
11/28 9:37:48.153 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2502f) corresponds to expired ROD(0x000002485FA51C30) will be removed.
11/28 9:37:50.153 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25031) corresponds to expired ROD(0x000002485FA51360) will be removed.
11/28 9:37:52.153 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25032) corresponds to expired ROD(0x000002485FA52AE0) will be removed.
11/28 9:37:54.154 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25033) corresponds to expired ROD(0x000002485FA51070) will be removed.
11/28 9:37:54.154 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25035) corresponds to expired ROD(0x000002485FA51940) will be removed.
11/28 9:37:56.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25034) corresponds to expired ROD(0x000002485FA51650) will be removed.
11/28 9:37:56.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25037) corresponds to expired ROD(0x000002485FA51F20) will be removed.
11/28 9:37:58.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25036) corresponds to expired ROD(0x000002485FA527F0) will be removed.
11/28 9:37:58.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25039) corresponds to expired ROD(0x000002485FA52500) will be removed.
11/28 9:37:58.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2503d) corresponds to expired ROD(0x0000024878BBC540) will be removed.
11/28 9:38:00.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25038) corresponds to expired ROD(0x000002485FA52210) will be removed.
11/28 9:38:00.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2503e) corresponds to expired ROD(0x0000024878BBC830) will be removed.
11/28 9:38:00.170 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25044) corresponds to expired ROD(0x0000024878BBB980) will be removed.
11/28 9:38:02.171 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2503c) corresponds to expired ROD(0x0000024878BBBF60) will be removed.
11/28 9:38:02.171 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25048) corresponds to expired ROD(0x0000024878BBB0B0) will be removed.
11/28 9:38:04.187 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25041) corresponds to expired ROD(0x0000024878BBB690) will be removed.
11/28 9:38:04.187 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25051) corresponds to expired ROD(0x0000024878BBB3A0) will be removed.
11/28 9:38:06.187 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2504c) corresponds to expired ROD(0x0000024878BBBC70) will be removed.
11/28 9:38:06.187 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25055) corresponds to expired ROD(0x0000024878BBCB20) will be removed.
11/28 9:38:08.203 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25052) corresponds to expired ROD(0x0000024878BBC250) will be removed.
11/28 9:38:08.203 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25059) corresponds to expired ROD(0x000002485FA51360) will be removed.
11/28 9:38:10.203 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25057) corresponds to expired ROD(0x000002485FA51070) will be removed.
11/28 9:38:10.203 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2505e) corresponds to expired ROD(0x000002485FA52AE0) will be removed.
11/28 9:38:12.204 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2505a) corresponds to expired ROD(0x000002485FA51650) will be removed.
11/28 9:38:12.204 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25061) corresponds to expired ROD(0x000002485FA52210) will be removed.
11/28 9:38:14.220 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2505f) corresponds to expired ROD(0x000002485FA51940) will be removed.
11/28 9:38:14.220 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25064) corresponds to expired ROD(0x000002485FA52500) will be removed.
11/28 9:38:16.235 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25063) corresponds to expired ROD(0x000002485FA51C30) will be removed.
11/28 9:38:16.235 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25069) corresponds to expired ROD(0x000002485FA527F0) will be removed.
11/28 9:38:18.236 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25065) corresponds to expired ROD(0x000002485FA51F20) will be removed.
11/28 9:38:18.236 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2506d) corresponds to expired ROD(0x0000024878BBC830) will be removed.
11/28 9:38:20.252 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2506b) corresponds to expired ROD(0x0000024878BBB0B0) will be removed.
11/28 9:38:20.252 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25071) corresponds to expired ROD(0x0000024878BBBF60) will be removed.
11/28 9:38:22.252 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2506e) corresponds to expired ROD(0x0000024878BBCB20) will be removed.
11/28 9:38:22.252 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25074) corresponds to expired ROD(0x0000024878BBB690) will be removed.
11/28 9:38:24.268 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25072) corresponds to expired ROD(0x0000024878BBB3A0) will be removed.
...[snip]...
11/28 22:21:05.989 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x201e5) corresponds to expired ROD(0x0000024847781830) will be removed.
11/28 22:44:48.141 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2552d) corresponds to expired ROD(0x000002484777E930) will be removed.
11/28 22:44:50.157 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2552f) corresponds to expired ROD(0x000002484777EC20) will be removed.
11/28 22:44:52.172 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25531) corresponds to expired ROD(0x000002484777E060) will be removed.
11/28 22:44:52.172 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25535) corresponds to expired ROD(0x000002484777FDC0) will be removed.
11/28 22:44:52.172 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25539) corresponds to expired ROD(0x00000248477803A0) will be removed.
11/28 22:44:54.188 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25533) corresponds to expired ROD(0x0000024847780C70) will be removed.
11/28 22:44:54.188 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2553b) corresponds to expired ROD(0x0000024847780690) will be removed.
11/28 22:44:54.188 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25537) corresponds to expired ROD(0x0000024847781540) will be removed.
11/28 22:58:29.722 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2553d) corresponds to expired ROD(0x000002484777FAD0) will be removed.
11/28 22:58:29.722 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x25541) corresponds to expired ROD(0x00000248477800B0) will be removed.
11/28 22:58:29.722 18f0 SCSI: CCopyManager::SchedulerThread: Populate token (operation id 0x2553f) corresponds to expired ROD(0x000002484777FDC0) will be removed.
Top
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Thu Nov 30, 2017 12:36 pm

Hi AndrewBucklin,
The messages you see do not mean errors. These are only notification messages from ODX about data block time living.
Top
AndrewBucklin
Posts: 4
Joined: Thu Jan 05, 2017 4:16 am

Fri Dec 01, 2017 12:42 am

Ok, thanks Oleg. I had some other issues going on and thought to check the Server Log of StarWind during my research and wasn't sure what I should expect to see in the Server Log.
Do you have any guidance on how to read the log; specifically, what types of things I should be looking for in the log that would be a sign of problems? Maybe certain keywords? Or should I ignore the Server Log and only look at the "Events" tab?
Top
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Fri Dec 01, 2017 11:15 am

AndrewBucklin,
You can find most frequent log entries in StarWind logs in this knowledgebase article:
https://knowledgebase.starwindsoftware. ... ting-note/
Top
Post Reply

Return to “StarWind Virtual SAN (VSAN) [+Free], HCI Appliance (HCA), Virtual HCI Appliance (VHCA) [+Free]”