Skip to content

Pod Fails Mounting Volume - Device Attach Timeout #1850

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Closed
chrisblatt opened this issue Apr 8, 2025 · 12 comments
Closed

Pod Fails Mounting Volume - Device Attach Timeout #1850

chrisblatt opened this issue Apr 8, 2025 · 12 comments

Comments

@chrisblatt
Copy link

Describe the bug
Originally I ran into this bug on creating a DiskPool for my nodes backed by 14TB RAID: openebs/openebs#3820 but was able to get past that issue.

Now I am trying to create a PVC and mount it to a pod. The PVC creates correctly, I can see the volume and volume replicas. Originally I was getting an error on the attachdetach-controller about a grpc timeout, turning off the firewall temporarily fixed that issue, but I will have to dig into that more later. After I turned off the node firewalls the volume attached successfully but the mount is failing with this error:

Events:
  Type     Reason                  Age                 From                     Message
  ----     ------                  ----                ----                     -------
  Normal   SuccessfulAttachVolume  18m                 attachdetach-controller  AttachVolume.Attach succeeded for volume "pvc-17f65eb3-8fb8-41c7-8631-c19be44d36e6"
  Warning  FailedMount             93s (x15 over 18m)  kubelet                  MountVolume.MountDevice failed for volume "pvc-17f65eb3-8fb8-41c7-8631-c19be44d36e6" : rpc error: code = Unavailable desc = Failed to stage volume 17f65eb3-8fb8-41c7-8631-c19be44d36e6: device attach timeout

A big cavaet is that I only have 2 storage nodes for this testing, my availability of physical hardware is limited so I adjusted the openebs helm chart to have 2 replicas of etcd and I am testing 1 and 2 replica volumes.

I also noticed some concerning logs:
io-engine pod logs on node with pod trying to mount volume:

[2025-04-08T14:30:03.469953667+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:1496] Creating new nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' (1 child(ren): ["bdev:///852c8094-cef6-4236-960f-71237cfb86fe?uuid=852c8094-cef6-4236-960f-71237cfb86fe"])...
[2025-04-08T14:30:03.470024510+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:406] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: creating new nexus bdev with UUID '5fbfe087-a3ba-42b6-924d-fa87a7db0d6f'
[2025-04-08T14:30:03.470031461+00:00  INFO io_engine::bdev::nexus::nexus_bdev_children:nexus_bdev_children.rs:58] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: adding child: 'bdev:///852c8094-cef6-4236-960f-71237cfb86fe?uuid=852c8094-cef6-4236-960f-71237cfb86fe'...
[2025-04-08T14:30:03.470056328+00:00  INFO io_engine::bdev::nexus::nexus_bdev_children:nexus_bdev_children.rs:65] Child 'bdev:///852c8094-cef6-4236-960f-71237cfb86fe?uuid=852c8094-cef6-4236-960f-71237cfb86fe @ 17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init synced]: added to nexus
[2025-04-08T14:30:03.470063228+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:769] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: registering nexus bdev...
[2025-04-08T14:30:03.470067140+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:748] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: nexus device initialized: requested=262144000 blocks (134217728000 bytes) start block=10240, end block=262143966, block size=512, smallest devices size=262144000 blocks
[2025-04-08T14:30:03.470075388+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:777] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: IO device registered
[2025-04-08T14:30:03.470083617+00:00  WARN io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:1366] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: I/O type 'Copy' support not implemented
[2025-04-08T14:30:03.470092518+00:00  INFO io_engine::bdev::nexus::nexus_bdev_children:nexus_bdev_children.rs:459] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: opening nexus children...
[2025-04-08T14:30:03.470097485+00:00  INFO io_engine::bdev::nexus::nexus_child:nexus_child.rs:361] Child 'bdev:///852c8094-cef6-4236-960f-71237cfb86fe?uuid=852c8094-cef6-4236-960f-71237cfb86fe @ 17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init synced]: opening child device...
[2025-04-08T14:30:03.470125592+00:00  INFO io_engine::bdev::nexus::nexus_child:nexus_child.rs:409] Child 'bdev:///852c8094-cef6-4236-960f-71237cfb86fe?uuid=852c8094-cef6-4236-960f-71237cfb86fe @ 17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open synced]: opened successfully
[2025-04-08T14:30:03.470151628+00:00  INFO io_engine::bdev::nexus::nexus_bdev_children:nexus_bdev_children.rs:541] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: all nexus children successfully opened: required_alignment=512
[2025-04-08T14:30:03.470156707+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:794] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [init]: children opened successfully
[2025-04-08T14:30:03.470195095+00:00  INFO io_engine::persistent_store:persistent_store.rs:171] Putting key /openebs.io/mayastor/apis/v0/clusters/23697556-02b1-4d74-a133-e957d4d46e20/namespaces/openebs/volume/17f65eb3-8fb8-41c7-8631-c19be44d36e6/nexus/5fbfe087-a3ba-42b6-924d-fa87a7db0d6f/info, value {"children":[{"healthy":true,"uuid":"852c8094-cef6-4236-960f-71237cfb86fe"}],"clean_shutdown":false} in store.
[2025-04-08T14:30:03.472630076+00:00  INFO io_engine::persistent_store:persistent_store.rs:182] Successfully put key /openebs.io/mayastor/apis/v0/clusters/23697556-02b1-4d74-a133-e957d4d46e20/namespaces/openebs/volume/17f65eb3-8fb8-41c7-8631-c19be44d36e6/nexus/5fbfe087-a3ba-42b6-924d-fa87a7db0d6f/info, value {"children":[{"healthy":true,"uuid":"852c8094-cef6-4236-960f-71237cfb86fe"}],"clean_shutdown":false} in store.
[2025-04-08T14:30:03.472702701+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:816] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]: nexus bdev registered successfully
[2025-04-08T14:30:03.472709892+00:00  INFO io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:1599] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]: nexus created ok
[2025-04-08T14:30:03.472727017+00:00  INFO io_engine::grpc::v1::nexus:nexus.rs:423] Created nexus 17f65eb3-8fb8-41c7-8631-c19be44d36e6/5fbfe087-a3ba-42b6-924d-fa87a7db0d6f
[2025-04-08T14:30:03.475504511+00:00  INFO io_engine::bdev::nexus::nexus_share:nexus_share.rs:40] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]: sharing NVMF target...
[2025-04-08T14:30:03.475528662+00:00  WARN io_engine::bdev::nexus::nexus_bdev:nexus_bdev.rs:1366] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]: I/O type 'ZeroCopy' support not implemented
[2025-04-08T14:30:03.475556171+00:00  INFO io_engine::subsys::nvmf::subsystem:subsystem.rs:777] Subsystem start in progress... self=NvmfSubsystem { id: 1, subtype: "NVMe", subnqn: "nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6", sn: "DCS07745C26276BD5AEF", mn: "Mayastor NVMe controller", allow_any_host: false, ana_reporting: 1, listeners: Some([Transport ID { trtype: 3, trstring: "TCP", traddr: "192.168.88.238", trsvcid: "8420" }]) }
[2025-04-08T14:30:03.475766118+00:00  INFO io_engine::subsys::nvmf::subsystem:subsystem.rs:826] Subsystem start completed: Ok self=NvmfSubsystem { id: 1, subtype: "NVMe", subnqn: "nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6", sn: "DCS07745C26276BD5AEF", mn: "Mayastor NVMe controller", allow_any_host: false, ana_reporting: 1, listeners: Some([Transport ID { trtype: 3, trstring: "TCP", traddr: "192.168.88.238", trsvcid: "8420" }]) }
[2025-04-08T14:30:03.475779517+00:00  INFO io_engine::bdev::nexus::nexus_share:nexus_share.rs:50] Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]: shared NVMF target as 'nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6'
[2025-04-08T14:30:03.475784367+00:00  INFO io_engine::grpc::v1::nexus:nexus.rs:674] Published nexus 5fbfe087-a3ba-42b6-924d-fa87a7db0d6f under nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6 for ["nqn.2019-05.io.openebs:node-name:f3-4-5000-einstein"]
[2025-04-08T14:30:04.168978883+00:00  INFO io_engine::subsys::nvmf::subsystem:subsystem.rs:296] Host 'nqn.2019-05.io.openebs:node-name:f3-4-5000-einstein' connected to subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' on nexus 'Nexus '17f65eb3-8fb8-41c7-8631-c19be44d36e6' [open]'
[2025-04-08T14:30:13.361213563+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:30:23.606447605+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:30:33.841531240+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:30:44.086685900+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:30:54.321833267+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:04.567056076+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:14.802128984+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:25.047325371+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:35.282451776+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:45.527608092+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:31:55.762775290+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:06.007925762+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:16.243066462+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:26.488249278+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:36.723372585+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:46.968557434+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:32:57.203616033+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:07.448810754+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:17.683976451+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:27.929111591+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:38.164237822+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:48.409394701+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:33:58.645059136+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:34:08.880166566+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:34:19.125370878+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:34:29.360533260+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:34:39.605770341+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:34:49.840946033+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:00.086112609+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:10.321296273+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:20.566497368+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:30.801627619+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:41.046802750+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:35:51.281961556+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:01.527108451+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:11.762190499+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:22.007443765+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:32.242588235+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:42.487714785+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:36:52.723576827+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:02.968738406+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:13.203863023+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:23.449081270+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:33.684180272+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:43.929327571+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:37:54.164466245+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:04.409639452+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:14.644781062+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:24.880202087+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:35.125150998+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:45.360227625+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:38:55.605356158+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:05.840518667+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:16.085714204+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:26.320876143+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:36.565992767+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:46.801198677+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:39:57.046313409+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:07.281437770+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:17.526619099+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:27.761799593+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:38.006944918+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:48.242048852+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:40:58.487205331+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:08.722351241+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:18.967510298+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:29.202716434+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:39.447861610+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:49.682990103+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:41:59.928195432+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:42:10.163313491+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:42:20.408476334+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:42:30.643693338+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:42:40.888865901+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:42:51.124012589+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:01.369187048+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:11.604324132+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:21.849590620+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:32.084689407+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:42.329779880+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:43:52.564961733+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:02.800076524+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:13.045219348+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:23.280389486+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:33.525509495+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:43.760623477+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:44:54.005820047+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:04.240947286+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:14.486146533+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:24.721359711+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:34.966505115+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:45.201640071+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:45:55.446811579+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:05.682166799+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:15.927318226+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:26.162502202+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:36.407672229+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:46.642787446+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:46:56.887918343+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:07.123090092+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:17.368238725+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:27.603443762+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:37.848634055+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:48.083747806+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:47:58.329054853+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:08.564171367+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:18.809376781+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:29.044560400+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:39.289885810+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:49.524833458+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:48:59.759989244+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:49:10.005174175+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:49:20.240314166+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:49:30.485531219+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:49:40.720662385+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:49:50.965814522+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:01.201060121+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:11.446686306+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:21.681811043+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:31.927026563+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:42.162128510+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:50:52.407234084+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:02.642412096+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:12.887574618+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:23.122777366+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:33.367887209+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:43.603037341+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:51:53.848217657+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:04.083337858+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:14.328527162+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:24.563677592+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:34.808818629+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:45.043929910+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:52:55.289091553+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:05.524222726+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:15.769387956+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:26.004645548+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:36.249866816+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:46.484884621+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:53:56.719985997+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:06.965155482+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:17.200278838+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:27.445506160+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:37.680678099+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:47.925846891+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:54:58.160982491+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:55:08.406146864+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'
[2025-04-08T14:55:18.641281791+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'

This is from the csi node pod on the node with the pod:

2025-04-08T14:29:09.660210Z  WARN csi_node::dev::nvmf: Block device nvme0n1 for volume uuid.17f65eb3-8fb8-41c7-8631-c19be44d36e6 has no controller!
    at control-plane/csi-driver/src/bin/node/dev/nvmf.rs:366
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "17f65eb3-8fb8-41c7-8631-c19be44d36e6", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/bdfc12a5d811d86e8686fb6870a83a9ce6d71afbc8451b34c9877bbe79ba1ea3/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"protocol": "nvmf", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "csi.storage.k8s.io/pv/name": "pvc-17f65eb3-8fb8-41c7-8631-c19be44d36e6", "storage.kubernetes.io/csiProvisionerIdentity": "1744049363538-1690-io.openebs.csi-mayastor", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "17f65eb3-8fb8-41c7-8631-c19be44d36e6"

  2025-04-08T14:29:20.369620Z ERROR csi_node::node: Failed to stage volume 17f65eb3-8fb8-41c7-8631-c19be44d36e6: device attach timeout
    at control-plane/csi-driver/src/bin/node/node.rs:775
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "17f65eb3-8fb8-41c7-8631-c19be44d36e6", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/bdfc12a5d811d86e8686fb6870a83a9ce6d71afbc8451b34c9877bbe79ba1ea3/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"protocol": "nvmf", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "csi.storage.k8s.io/pv/name": "pvc-17f65eb3-8fb8-41c7-8631-c19be44d36e6", "storage.kubernetes.io/csiProvisionerIdentity": "1744049363538-1690-io.openebs.csi-mayastor", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "17f65eb3-8fb8-41c7-8631-c19be44d36e6"

  2025-04-08T14:29:20.369642Z ERROR csi_node::node: error: status: Unavailable, message: "Failed to stage volume 17f65eb3-8fb8-41c7-8631-c19be44d36e6: device attach timeout", details: [], metadata: MetadataMap { headers: {} }
    at control-plane/csi-driver/src/bin/node/node.rs:654
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "17f65eb3-8fb8-41c7-8631-c19be44d36e6", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/bdfc12a5d811d86e8686fb6870a83a9ce6d71afbc8451b34c9877bbe79ba1ea3/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"protocol": "nvmf", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "csi.storage.k8s.io/pv/name": "pvc-17f65eb3-8fb8-41c7-8631-c19be44d36e6", "storage.kubernetes.io/csiProvisionerIdentity": "1744049363538-1690-io.openebs.csi-mayastor", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "17f65eb3-8fb8-41c7-8631-c19be44d36e6"

To Reproduce
Create 1 or 2 replica volume
Create pod attaching PVC and monitor if it mounts.

Expected behavior
A clear and concise description of what you expected to happen.

Screenshots
If applicable, add screenshots to help explain your problem.

** OS info (please complete the following information):**

  • Distro: [e.g. NixOS] Rocky 8.10 and Rocky 8.9
  • Kernel version 4.18.0-553.16.1.el8_10.x86_64 and 4.18.0-513.9.1.el8_9.x86_64
  • MayaStor revision or container image 2.8.0

Additional context
2 physical servers running rocky 8.9 and 8.10
2 raid pools per node 1 for OS and 1 for OpenEBS data (both luks encrypted)
k8s 1.31.1
openebs 4.2

@chrisblatt
Copy link
Author

Here is a support bundle generated:

mayastor-2025-04-08--15-01-48-UTC.tar.gz

@chrisblatt
Copy link
Author

I was able to solve the initial firewall issue with the attachdetach-controller more specific than turning the firewall off,
I had to open port 10199/tcp, but I don't see that in OpenEBS docs as a pre-req, not sure if its specific to these physical servers or something.

Warning  FailedAttachVolume      5m50s (x11 over 12m)  attachdetach-controller  AttachVolume.Attach failed for volume "pvc-fc01dc97-47e0-44b9-ba96-6d6e04e4d80e" : rpc error: code = Unavailable desc = transport error
  Normal   SuccessfulAttachVolume  3m48s                 attachdetach-controller  AttachVolume.Attach succeeded for volume "pvc-fc01dc97-47e0-44b9-ba96-6d6e04e4d80e"

firewall deny logs before I opened the port and the attach succeeded:

[77267.731440] FINAL_REJECT: IN=ens99f0 OUT= MAC=<removed> SRC=192.168.88.238 DST=192.168.88.2 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=38845 DF PROTO=TCP SPT=51482 DPT=10199 WINDOW=29200 RES=0x00 SYN URGP=0
[77395.739602] FINAL_REJECT: IN=ens99f0 OUT= MAC=<removed> SRC=192.168.88.238 DST=192.168.88.2 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=52754 DF PROTO=TCP SPT=45018 DPT=10199 WINDOW=29200 RES=0x00 SYN URGP=0

@chrisblatt
Copy link
Author

I did some more testing, I was able to see the volume was mounted to the node at /dev/nvme0n1 or something like that. I was able to add a filesystem to the device and mount it to the node so the nvme over tcp piece seems to be working to me, something is failing on the k8s/kubelet/csi side with mounting the volume to the pod.

@tiagolobocastro
Copy link
Contributor

[2025-04-08T14:55:18.641281791+00:00 ERROR mayastor::spdk:ctrlr.c:838] Subsystem 'nqn.2019-05.io.openebs:17f65eb3-8fb8-41c7-8631-c19be44d36e6' does not allow host 'nqn.2019-05.io.openebs:node-name:f5-6-t4-1'

Something seems off here.
Could you please try deleting the application consuming the volume and re-creating?

@chrisblatt
Copy link
Author

I recreated the pod and volume but the same kubelet mount error persists. It does look like the subsystem error is gone from the logs now though and I see the volume is mounted on the node:

# nvme list
Node                  SN                   Model                                    Namespace Usage                      Format           FW Rev
--------------------- -------------------- ---------------------------------------- --------- -------------------------- ---------------- --------
/dev/nvme0n1          DCS2F62F3584E03242E6 Mayastor NVMe controller                 1         134.21  GB / 134.21  GB    512   B +  0 B   24.05.1

io-engine pod logs look better:

[2025-04-09T15:49:22.103845541+00:00  INFO async_nats:lib.rs:996] event: connected
TELEMETRY: No legacy callbacks, legacy socket not created
[2025-04-09T15:49:22.148272929+00:00  INFO io_engine::core::mempool:mempool.rs:48] Memory pool 'bdev_io_ctx' with 65535 elements (24 bytes size) successfully created
[2025-04-09T15:49:22.151854064+00:00  INFO io_engine::core::mempool:mempool.rs:48] Memory pool 'nvme_ctrl_io_ctx' with 65535 elements (72 bytes size) successfully created
[2025-04-09T15:49:22.151865573+00:00  INFO io_engine::core::env:env.rs:1015] Total number of cores available: 2
[2025-04-09T15:49:22.168938916+00:00  INFO io_engine::core::reactor:reactor.rs:180] Scheduled SPDK thread 'init_thread' (0x557ba77c9e10) on core #1
[2025-04-09T15:49:22.168956097+00:00  INFO io_engine::core::reactor:reactor.rs:156] Init thread ID 1
[2025-04-09T15:49:22.169008994+00:00  INFO io_engine::core::reactor:reactor.rs:299] Starting reactor polling loop core=2 tid=13
[2025-04-09T15:49:22.170102268+00:00  INFO io_engine::core::env:env.rs:1050] All cores locked and loaded!
[2025-04-09T15:49:22.264578296+00:00  INFO io_engine::bdev::nexus::nexus_module:nexus_module.rs:36] Initializing Nexus CAS Module
[2025-04-09T15:49:22.264637115+00:00  INFO io_engine::core::reactor:reactor.rs:180] Scheduled SPDK thread 'mayastor_nvmf_tcp_pg_core_1' (0x557ba77cbb40) on core #1
[2025-04-09T15:49:22.264664503+00:00  INFO io_engine::core::reactor:reactor.rs:180] Scheduled SPDK thread 'mayastor_nvmf_tcp_pg_core_2' (0x557ba77cc1e0) on core #2
[2025-04-09T15:49:22.267580277+00:00  INFO io_engine::core::env:env.rs:875] Using 'MY_POD_IP' environment variable for IP address for NVMF target network interface
[2025-04-09T15:49:22.267700001+00:00  INFO io_engine::subsys::nvmf::target:target.rs:252] nvmf target listening(tcp) on 192.168.88.228:(4421,8420)
[2025-04-09T15:49:22.267715940+00:00  INFO io_engine::subsys::nvmf::subsystem:subsystem.rs:777] Subsystem start in progress... self=NvmfSubsystem { id: 0, subtype: "Discovery", subnqn: "nqn.2014-08.org.nvmexpress.discovery", sn: "00000000000000000000", mn: "Mayastor NVMe controller", allow_any_host: true, ana_reporting: 0, listeners: Some([Transport ID { trtype: 3, trstring: "TCP", traddr: "192.168.88.228", trsvcid: "8420" }]) }
[2025-04-09T15:49:22.267734553+00:00  INFO io_engine::subsys::nvmf::subsystem:subsystem.rs:826] Subsystem start completed: Ok self=NvmfSubsystem { id: 0, subtype: "Discovery", subnqn: "nqn.2014-08.org.nvmexpress.discovery", sn: "00000000000000000000", mn: "Mayastor NVMe controller", allow_any_host: true, ana_reporting: 0, listeners: Some([Transport ID { trtype: 3, trstring: "TCP", traddr: "192.168.88.228", trsvcid: "8420" }]) }
[2025-04-09T15:49:22.267739291+00:00  INFO io_engine::subsys::nvmf::target:target.rs:409] nvmf target accepting new connections and is ready to roll..💃
[2025-04-09T15:49:22.326628091+00:00  INFO io_engine::core::reactor:reactor.rs:180] Scheduled SPDK thread 'iscsi_poll_group_1' (0x557ba7985c50) on core #1
[2025-04-09T15:49:22.326980469+00:00  INFO io_engine::core::reactor:reactor.rs:180] Scheduled SPDK thread 'iscsi_poll_group_2' (0x557ba7985ff0) on core #2
[2025-04-09T15:49:22.327012251+00:00  INFO io_engine::core::env:env.rs:900] RPC server listening at: /var/tmp/mayastor.sock
[2025-04-09T15:49:22.327727950+00:00  WARN io_engine:io-engine.rs:76] Nexus reset is disabled
[2025-04-09T15:49:22.327738997+00:00  INFO io_engine:io-engine.rs:110] Async QPair connection feature ('spdk-async-qpair-connect') is enabled
[2025-04-09T15:49:22.327741718+00:00  INFO io_engine:io-engine.rs:111] Fault injection feature ('fault-injection') is disabled
[2025-04-09T15:49:22.343211487+00:00  INFO io_engine::persistent_store:persistent_store.rs:144] Connected to etcd on endpoint openebs-etcd:2379
[2025-04-09T15:49:22.343237577+00:00  INFO io_engine::persistent_store:persistent_store.rs:120] Persistent store operation timeout: 10s, number of retries: 300
[2025-04-09T15:49:22.343262027+00:00  INFO io_engine::grpc::server:server.rs:67] [V1] gRPC server configured at address 192.168.88.228:10124
[2025-04-09T15:49:22.345360329+00:00  INFO io_engine::subsys::registration::registration_grpc:registration_grpc.rs:203] Registering '"f5-6-t4-1"' with grpc server 192.168.88.228:10124 ...

@chrisblatt
Copy link
Author

Still seeing these errors in the csi-node logs for the node running the pod (successfully looks to have mounted the volume to /dev/nvme0n1:

2025-04-09T16:14:29.230141Z  WARN csi_node::dev::nvmf: Block device nvme0n1 for volume uuid.469a8c5c-d6d4-4ccb-8dcc-285670f8dfca has no controller!
    at control-plane/csi-driver/src/bin/node/dev/nvmf.rs:366
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:469a8c5c-d6d4-4ccb-8dcc-285670f8dfca?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/aa0890ae0a7bca836b026433a7546dbda2497a5b105706b990fffa4824d4e417/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"storage.kubernetes.io/csiProvisionerIdentity": "1744211097787-7064-io.openebs.csi-mayastor", "csi.storage.k8s.io/pv/name": "pvc-469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "protocol": "nvmf", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca"

  2025-04-09T16:14:39.904823Z ERROR csi_node::node: Failed to stage volume 469a8c5c-d6d4-4ccb-8dcc-285670f8dfca: device attach timeout
    at control-plane/csi-driver/src/bin/node/node.rs:775
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:469a8c5c-d6d4-4ccb-8dcc-285670f8dfca?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/aa0890ae0a7bca836b026433a7546dbda2497a5b105706b990fffa4824d4e417/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"storage.kubernetes.io/csiProvisionerIdentity": "1744211097787-7064-io.openebs.csi-mayastor", "csi.storage.k8s.io/pv/name": "pvc-469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "protocol": "nvmf", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca"

  2025-04-09T16:14:39.904846Z ERROR csi_node::node: error: status: Unavailable, message: "Failed to stage volume 469a8c5c-d6d4-4ccb-8dcc-285670f8dfca: device attach timeout", details: [], metadata: MetadataMap { headers: {} }
    at control-plane/csi-driver/src/bin/node/node.rs:654
    in csi_node::node::node_stage_volume with request: Request { metadata: MetadataMap { headers: {"content-type": "application/grpc", "user-agent": "grpc-go/1.65.0", "te": "trailers", "grpc-accept-encoding": "gzip", "grpc-timeout": "119997m"} }, message: NodeStageVolumeRequest { volume_id: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", publish_context: {"uri": "nvmf://192.168.88.238:8420/nqn.2019-05.io.openebs:469a8c5c-d6d4-4ccb-8dcc-285670f8dfca?hostnqn=nqn.2019-05.io.openebs:node-name:f5-6-t4-1"}, staging_target_path: "/var/lib/kubelet/plugins/kubernetes.io/csi/io.openebs.csi-mayastor/aa0890ae0a7bca836b026433a7546dbda2497a5b105706b990fffa4824d4e417/globalmount", volume_capability: Some(VolumeCapability { access_mode: Some(AccessMode { mode: SingleNodeWriter }), access_type: Some(Mount(MountVolume { fs_type: "ext4", mount_flags: [], volume_mount_group: "" })) }), secrets: {}, volume_context: {"storage.kubernetes.io/csiProvisionerIdentity": "1744211097787-7064-io.openebs.csi-mayastor", "csi.storage.k8s.io/pv/name": "pvc-469a8c5c-d6d4-4ccb-8dcc-285670f8dfca", "csi.storage.k8s.io/pvc/name": "test-repl1-pvc", "protocol": "nvmf", "csi.storage.k8s.io/pvc/namespace": "default", "repl": "1"} }, extensions: Extensions }, volume.uuid: "469a8c5c-d6d4-4ccb-8dcc-285670f8dfca"

@tiagolobocastro
Copy link
Contributor

Please share dmesg logs from the application node

@chrisblatt
Copy link
Author

Here are the dmesg logs from that time period: NOTE: confusing I know but io-engine logs look to be in UTC time and this system time is PDT

[Wed Apr  9 08:23:03 2025] nvme nvme0: starting error recovery
[Wed Apr  9 08:23:03 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:23:13 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:23:13 2025] nvme nvme0: Failed reconnect attempt 1
[Wed Apr  9 08:23:13 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:23:24 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:23:24 2025] nvme nvme0: Failed reconnect attempt 2
[Wed Apr  9 08:23:24 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:23:34 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:23:34 2025] nvme nvme0: Failed reconnect attempt 3
[Wed Apr  9 08:23:34 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:23:44 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:23:44 2025] nvme nvme0: Failed reconnect attempt 4
[Wed Apr  9 08:23:44 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:23:54 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:23:54 2025] nvme nvme0: Failed reconnect attempt 5
[Wed Apr  9 08:23:54 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:05 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:05 2025] nvme nvme0: Failed reconnect attempt 6
[Wed Apr  9 08:24:05 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:15 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:15 2025] nvme nvme0: Failed reconnect attempt 7
[Wed Apr  9 08:24:15 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:25 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:25 2025] nvme nvme0: Failed reconnect attempt 8
[Wed Apr  9 08:24:25 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:35 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:35 2025] nvme nvme0: Failed reconnect attempt 9
[Wed Apr  9 08:24:35 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:46 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:46 2025] nvme nvme0: Failed reconnect attempt 10
[Wed Apr  9 08:24:46 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:24:56 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:24:56 2025] nvme nvme0: Failed reconnect attempt 11
[Wed Apr  9 08:24:56 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:06 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:06 2025] nvme nvme0: Failed reconnect attempt 12
[Wed Apr  9 08:25:06 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:16 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:16 2025] nvme nvme0: Failed reconnect attempt 13
[Wed Apr  9 08:25:16 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:27 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:27 2025] nvme nvme0: Failed reconnect attempt 14
[Wed Apr  9 08:25:27 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:37 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:37 2025] nvme nvme0: Failed reconnect attempt 15
[Wed Apr  9 08:25:37 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:47 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:47 2025] nvme nvme0: Failed reconnect attempt 16
[Wed Apr  9 08:25:47 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:25:57 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:25:57 2025] nvme nvme0: Failed reconnect attempt 17
[Wed Apr  9 08:25:57 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:26:08 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:26:08 2025] nvme nvme0: Failed reconnect attempt 18
[Wed Apr  9 08:26:08 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:26:18 2025] nvme nvme0: failed to connect socket: -111
[Wed Apr  9 08:26:18 2025] nvme nvme0: Failed reconnect attempt 19
[Wed Apr  9 08:26:18 2025] nvme nvme0: Reconnecting in 10 seconds...
[Wed Apr  9 08:26:26 2025] nvme nvme0: Removing ctrl: NQN "nqn.2014-08.org.nvmexpress.discovery"
[Wed Apr  9 08:26:26 2025] nvme nvme0: Property Set error: 880, offset 0x14

@chrisblatt
Copy link
Author

I just tried this again and get the same error but here is the dmesg logs from the node. Here is the volume as well with the replicas

# k get pvc
NAME             STATUS   VOLUME                                     CAPACITY   ACCESS MODES   STORAGECLASS             VOLUMEATTRIBUTESCLASS   AGE
test-repl1-pvc   Bound    pvc-70261f3d-7db9-434a-95af-8e49737ab070   125Gi      RWO            openebs-single-replica   <unset>                 3m39s
# k mayastor get volumes -n openebs
 ID                                    REPLICAS  TARGET-NODE  ACCESSIBILITY  STATUS  SIZE    THIN-PROVISIONED  ALLOCATED  SNAPSHOTS  SOURCE
 70261f3d-7db9-434a-95af-8e49737ab070  1         f5-6-t4-1    nvmf           Online  125GiB  false             125GiB     0          <none>
# k mayastor get volume-replica-topologies -n openebs
 VOLUME-ID                             ID                                    NODE       POOL           STATUS  CAPACITY  ALLOCATED  SNAPSHOTS  CHILD-STATUS  REASON  REBUILD
 70261f3d-7db9-434a-95af-8e49737ab070  260fdabd-2430-4051-827c-38c8216006f8  f5-6-t4-1  dsp-f5-6-t4-1  Online  125GiB    125GiB     0 B        Online        <none>  <none>
[Thu Apr 10 12:52:56 2025] nvme nvme0: queue_size 128 > ctrl sqsize 32, clamping down
[Thu Apr 10 12:52:56 2025] nvme nvme0: creating 2 I/O queues.
[Thu Apr 10 12:52:56 2025] nvme nvme0: mapped 2/0/0 default/read/poll queues.
[Thu Apr 10 12:52:56 2025] nvme nvme0: new ctrl: NQN "nqn.2019-05.io.openebs:70261f3d-7db9-434a-95af-8e49737ab070", addr 192.168.88.228:8420
[Thu Apr 10 12:52:56 2025] nvme0n1: detected capacity change from 0 to 134212467712

@tiagolobocastro
Copy link
Contributor

Aha, I think it's this: #1838
Could you please editing the csi-node daemonset image tag to develop ?

@chrisblatt
Copy link
Author

That image tag worked, and yes the tagged issue makes sense. I hadn't rebooted the nodes yet to have the modified boot parameters take over, thinking that could wait until I did some initial testing.

@tiagolobocastro
Copy link
Contributor

Great, thank you for confirming!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants