2190129 – OCS Provider Server logs are incorrect

Bug 2190129 - OCS Provider Server logs are incorrect

Summary: OCS Provider Server logs are incorrect

Keywords:
Status:	CLOSED ERRATA
Alias:	None
Product:	Red Hat OpenShift Data Foundation
Classification:	Red Hat Storage
Component:	ocs-operator
Sub Component:
Version:	4.12
Hardware:	Unspecified
OS:	Unspecified
Priority:	unspecified
Severity:	unspecified
Target Milestone:	---
Target Release:	ODF 4.13.0
Assignee:	Mudit Agarwal
QA Contact:	Jilju Joy
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2023-04-27 09:00 UTC by Rewant
Modified:	2023-08-09 17:00 UTC (History)
CC List:	6 users (show)
Fixed In Version:
Doc Type:	No Doc Update
Doc Text:
Clone Of:
Environment:
Last Closed:	2023-06-21 15:25:28 UTC
Embargoed:

Attachments	(Terms of Use)

Links
System	ID	Priority	Status	Summary	Last Updated
Github	red-hat-storage ocs-operator pull 2039	None	open	fix logging for the storageclassclaim in server	2023-04-27 10:05:53 UTC
Github	red-hat-storage ocs-operator pull 2041	None	open	BUG 2190129: fix logging for the storageclassclaim in server	2023-04-27 12:12:17 UTC
Red Hat Product Errata	RHBA-2023:3742	None	None	None	2023-06-21 15:25:44 UTC

Description Rewant 2023-04-27 09:00:36 UTC

Description of problem (please be detailed as possible and provide log
snippests):

The logs for ocs provider server are not correct. 

```
I0427 08:43:30.391702       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-db8d31ed8565642846bac0aec195082f" for consumer "c8dfee37-44eb-4165-a3a6-1199cecd9070" and request "ocs-storagecluster-cephfs"
I0427 08:43:30.397083       1 server.go:548] storage class request "ocs-storagecluster-cephfs" for "c8dfee37-44eb-4165-a3a6-1199cecd9070" is in "Creating" phase
I0427 08:43:30.555653       1 server.go:497] Found StorageConsumer "storageconsumer-55fbcc2b-2155-4c37-91b9-7613c0ca762f" ("c8dfee37-44eb-4165-a3a6-1199cecd9070")
I0427 08:43:30.565308       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-5f5593a973be481a70b1450debef9770" for consumer "c8dfee37-44eb-4165-a3a6-1199cecd9070" and request "ocs-storagecluster-ceph-rbd"
I0427 08:43:30.569824       1 server.go:548] storage class request "ocs-storagecluster-ceph-rbd" for "c8dfee37-44eb-4165-a3a6-1199cecd9070" is in "Creating" phase
I0427 08:43:32.992883       1 server.go:497] Found StorageConsumer "storageconsumer-55fbcc2b-2155-4c37-91b9-7613c0ca762f" ("c8dfee37-44eb-4165-a3a6-1199cecd9070")
I0427 08:43:33.002923       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-db8d31ed8565642846bac0aec195082f" for consumer "c8dfee37-44eb-4165-a3a6-1199cecd9070" and request "ocs-storagecluster-cephfs"

```

It says that storage class request "ocs-storagecluster-cephfs" for "c8dfee37-44eb-4165-a3a6-1199cecd9070" is in "Creating" phase, but the name for storageClassRequest is not ocs-storagecluster-cephfs, it is "storageclassrequest-db8d31ed8565642846bac0aec195082f". similarly we have the same incorrect logs for rdb.

Version of all relevant components (if applicable):
tested it on 4.12.3-11

Does this issue impact your ability to continue to work with the product
(please explain in detail what is the user impact)?
No, it doesn't impact the product but it will be a good to have fix so that it doesn't become confusing.

Is there any workaround available to the best of your knowledge?


Rate from 1 - 5 the complexity of the scenario you performed that caused this
bug (1 - very simple, 5 - very complex)?


Can this issue reproducible?
Yes

Can this issue reproduce from the UI?


If this is a regression, please provide more details to justify this:


Steps to Reproduce:
1.
2.
3.


Actual results:
StorageClassRequest resource "storageclassrequest-db8d31ed8565642846bac0aec195082f" for consumer "c8dfee37-44eb-4165-a3a6-1199cecd9070" and request "ocs-storagecluster-cephfs"
I0427 08:43:30.397083       1 server.go:548] storage class request "ocs-storagecluster-cephfs" for "c8dfee37-44eb-4165-a3a6-1199cecd9070" is in "Creating" phase

Expected results:
StorageClassRequest resource "storageclassrequest-db8d31ed8565642846bac0aec195082f" for consumer "c8dfee37-44eb-4165-a3a6-1199cecd9070" and request "ocs-storagecluster-cephfs"
I0427 08:43:30.397083       1 server.go:548] storage class request "storageclassrequest-db8d31ed8565642846bac0aec195082f" for "c8dfee37-44eb-4165-a3a6-1199cecd9070" is in "Creating" phase

Additional info:

Comment 7 suchita 2023-05-10 19:05:30 UTC

-----------------ocs-provider-server log from Faas Provider Cluster ocs4.13.0-186----------------------------------------

$ oc logs ocs-provider-server-c479f9957-jsscw
I0510 14:15:09.343427       1 main.go:22] Starting Provider API server
I0510 14:15:10.395708       1 request.go:690] Waited for 1.037021173s due to client-side throttling, not priority and fairness, request: GET:https://172.30.0.1:443/apis/performance.openshift.io/v1?timeout=32s
E0510 14:55:55.698386       1 consumer.go:209] no storageConsumer found with the UID ""
I0510 14:55:55.708685       1 server.go:483] onboarding ticket D169EB64-540B-4B25-8416-325BA4B20276 has been verified successfully
I0510 14:55:55.726476       1 consumer.go:96] successfully created storageConsumer resource "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f"
E0510 14:55:55.730559       1 consumer.go:209] no storageConsumer found with the UID ""
E0510 14:55:55.750051       1 consumer.go:209] no storageConsumer found with the UID ""
I0510 14:55:55.762198       1 consumer.go:184] successfully Enabled the StorageConsumer resource "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f"
I0510 14:55:55.770967       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
E0510 14:55:55.805589       1 consumer.go:180] Failed to enable storageConsumer Operation cannot be fulfilled on storageconsumers.ocs.openshift.io "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f": the object has been modified; please apply your changes to the latest version and try again
I0510 14:55:55.866687       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:55.872603       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "" phase
I0510 14:55:55.900755       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:55.908634       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:55.931771       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "" phase
I0510 14:55:55.964529       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.011003       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:56.031998       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.060539       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.075009       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:56.084385       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.107312       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.122016       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:56.174017       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.198037       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.212667       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:56.217826       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.249494       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.263029       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:56.269325       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.333047       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.347225       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:56.355622       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.402123       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.418471       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:56.424401       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.562736       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.579303       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:56.587310       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.629798       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.664146       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:56.670547       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:56.951826       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:56.965106       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:56.970385       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:57.019100       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:57.031998       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:57.037608       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:57.631127       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:57.643685       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:57.649124       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:57.707005       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:57.719637       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:57.724960       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:58.988526       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:59.002467       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:55:59.007449       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:55:59.054988       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:55:59.067467       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:55:59.072729       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:01.600465       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:01.613522       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:56:01.618833       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:01.667164       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:01.682987       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:56:01.692279       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:06.772322       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:06.785250       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:56:06.790185       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:06.843646       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:06.857018       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:56:06.862450       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:08.645076       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 14:56:08.651176       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:56:12.578427       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 14:56:12.583406       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:56:12.610544       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:56:17.056698       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:17.078770       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:56:17.084004       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:17.129370       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:17.142768       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:56:17.147720       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:37.594336       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:37.610836       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:56:37.616153       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Creating" phase
I0510 14:56:37.647955       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:37.660336       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:56:37.665282       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Ready" phase
I0510 14:56:37.691827       1 server.go:676] successfully returned the storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d"
I0510 14:56:37.696762       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:56:37.717874       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:56:38.290462       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:56:38.303087       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-4ddf43073067224eedc38562903d8c5d" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-cephfs"
I0510 14:56:38.308095       1 server.go:548] storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Ready" phase
I0510 14:56:38.337313       1 server.go:676] successfully returned the storage class claim "ocs-storagecluster-cephfs" for "82af86f4-dec3-475b-9bc6-1a28804d118d"
I0510 14:56:38.343534       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:56:38.368741       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:57:04.135856       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 14:57:04.141177       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:57:04.165421       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:57:18.605750       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:57:18.633649       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:57:18.639378       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Ready" phase
I0510 14:57:18.664939       1 server.go:676] successfully returned the storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d"
I0510 14:57:18.669667       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:57:18.695045       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:57:18.769369       1 server.go:497] Found StorageConsumer "storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f" ("82af86f4-dec3-475b-9bc6-1a28804d118d")
I0510 14:57:18.788758       1 storageclassrequest.go:124] successfully created a StorageClassRequest resource "storageclassrequest-3919aa557485029c1124ea29431fffad" for consumer "82af86f4-dec3-475b-9bc6-1a28804d118d" and request "ocs-storagecluster-ceph-rbd"
I0510 14:57:18.796241       1 server.go:548] storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d" is in "Ready" phase
I0510 14:57:18.835776       1 server.go:676] successfully returned the storage class claim "ocs-storagecluster-ceph-rbd" for "82af86f4-dec3-475b-9bc6-1a28804d118d"
I0510 14:57:18.841846       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:57:18.864434       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:58:04.152000       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 14:58:04.157148       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:58:04.184515       1 server.go:171] successfully returned the config details to the consumer.
I0510 14:59:04.326394       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 14:59:04.332710       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 14:59:04.365376       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:00:04.412335       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:00:04.425533       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:00:04.452329       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:01:04.124677       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:01:04.129533       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:01:04.153250       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:02:04.145906       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:02:04.151188       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:02:04.175492       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:03:04.112300       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:03:04.119279       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:03:04.146826       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:04:04.153188       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:04:04.162541       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:04:04.213475       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:05:04.143086       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:05:04.150379       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:05:04.176869       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:06:04.140711       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:06:04.146154       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:06:04.174053       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:07:04.202981       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:07:04.208584       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:07:04.231218       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:08:04.120774       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:08:04.127864       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:08:04.152473       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:09:04.466618       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:09:04.473461       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:09:04.520313       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:10:04.129969       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:10:04.135964       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:10:04.163992       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:11:04.168173       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:11:04.175330       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:11:04.200540       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:12:04.135033       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:12:04.141108       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:12:04.174004       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:13:04.125692       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:13:04.132926       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:13:04.157406       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:14:04.343025       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:14:04.348275       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:14:04.373630       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:15:04.139011       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:15:04.145440       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:15:04.173526       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:16:04.138675       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:16:04.145599       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:16:04.169492       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:17:04.151687       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:17:04.157917       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:17:04.186403       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:18:04.407540       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:18:04.412422       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:18:04.435711       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:19:04.131696       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:19:04.137801       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:19:04.160499       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:20:04.124355       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:20:04.129707       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:20:04.151968       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:21:04.143771       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:21:04.150363       1 server.go:153] Found storageConsumer for GetStorageConfig
I0510 15:21:04.179180       1 server.go:171] successfully returned the config details to the consumer.
I0510 15:22:04.137191       1 consumer.go:259] successfully updated Status.LastHeartbeat for StorageConsumer storageconsumer-e16bc58c-8c79-4c2d-aead-7381beb1a44f
I0510 15:22:04.155789       1 server.go:153] Found
-------------------------------------------------------------------------------------------

Comment 8 Jilju Joy 2023-05-30 07:01:33 UTC

Hi Madhu,

Referring to Comment #7, the cr name "storage class request" is changed to "storage class claim" in the logs. The provider will not have a storageclassclaim cr. Please check the logs

Comment 9 Madhu Rajanna 2023-05-30 07:32:52 UTC

(In reply to Jilju Joy from comment #8)
> Hi Madhu,
> 
> Referring to Comment #7, the cr name "storage class request" is changed to
> "storage class claim" in the logs. The provider will not have a
> storageclassclaim cr. Please check the logs

Hello Jilju, you are right. The provider cluster will not have the storageclassclaim CR, but it will receive RPC requests for it and those requests will be logged by the server. I apologize, but I am not quite sure what your question is. Can you please clarify?

Comment 15 errata-xmlrpc 2023-06-21 15:25:28 UTC

Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory (Red Hat OpenShift Data Foundation 4.13.0 enhancement and bug fix update), and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

https://access.redhat.com/errata/RHBA-2023:3742

Note You need to log in before you can comment on or make changes to this bug.