From: John Spray <john.spray@redhat.com>
Date: Fri, 15 Aug 2014 13:58:57 +0000 (+0100)
Subject: librados: verbose logging in ::notify
X-Git-Tag: v0.86~213^2~14
X-Git-Url: http://git-server-git.apps.pok.os.sepia.ceph.com/?a=commitdiff_plain;h=73e5bb0a31d8d80e753272832ae679019ae83632;p=ceph.git

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 d25fcbae8af..aadd04fe6fd 100644
--- 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