librados: verbose logging in ::notify

One is interested in knowning specifically which stage
of the operation we are at.

Signed-off-by: John Spray <john.spray@redhat.com>

diff --git a/src/librados/IoCtxImpl.cc b/src/librados/IoCtxImpl.cc
index d25fcbae8afa8ea7d80b84ab55e3706bc2a9dce7..aadd04fe6fdb98a62d40e3086536ba6ee9758066 100644 (file)
--- a/src/librados/IoCtxImpl.cc
+++ b/src/librados/IoCtxImpl.cc
@@ -1123,13 +1123,18 @@ int librados::IoCtxImpl::notify(const object_t& oid, uint64_t ver, bufferlist& b
                                        &onack, &objver);
   lock->Unlock();
 
+  ldout(client->cct, 10) << __func__ << " issued linger op " << wc->linger_id << dendl;
   int r_issue = onack.wait();
+  ldout(client->cct, 10) << __func__ << " linger op " << wc->linger_id << " acked (" << r_issue << ")" << dendl;
+
   if (r_issue == 0) {
+  ldout(client->cct, 10) << __func__ << "waiting for watch_notify message for linger op " << wc->linger_id << dendl;
     mylock_all.Lock();
     while (!done_all)
       cond_all.Wait(mylock_all);
     mylock_all.Unlock();
   }
+  ldout(client->cct, 10) << __func__ << " completed notify (linger op " << wc->linger_id << "), unregistering" << dendl;
 
   lock->Lock();
   client->unregister_watch_notify_callback(cookie);   // destroys wc