ctdb-ib: Fix DEBUG log messages
[vlendec/samba-autobuild/.git] / ctdb / ib / ibwrapper.c
index f7b233954d229ce6faf73747e6b711e3ddf28cdb..f7334b528e7af82097500c50096744c864575090 100644 (file)
@@ -8,7 +8,7 @@
  *
  * This program is free software; you can redistribute it and/or modify
  * it under the terms of the GNU General Public License as published by
- * the Free Software Foundation; either version 2 of the License, or
+ * the Free Software Foundation; either version 3 of the License, or
  * (at your option) any later version.
  *
  * This program is distributed in the hope that it will be useful,
  * GNU General Public License for more details.
  *
  * You should have received a copy of the GNU General Public License
- * along with this program; if not, write to the Free Software
- * Foundation, Inc., 675 Mass Ave, Cambridge, MA 02139, USA.
+ * along with this program; if not, see <http://www.gnu.org/licenses/>.
  */
 
-#include <stdlib.h>
-#include <string.h>
-#include <stdio.h>
-#include <errno.h>
-#include <sys/types.h>
-#include <netinet/in.h>
-#include <sys/socket.h>
-#include <netdb.h>
-#include <arpa/inet.h>
-#include <malloc.h>
+#include "replace.h"
+#include "system/network.h"
+
 #include <assert.h>
-#include <unistd.h>
+#include <talloc.h>
+#include <tevent.h>
 
-#include "includes.h"
-#include "lib/events/events.h"
-#include "ibwrapper.h"
+#include "lib/util/dlinklist.h"
+#include "lib/util/debug.h"
 
+#include "common/logging.h"
+
+#include <infiniband/kern-abi.h>
+#include <rdma/rdma_cma_abi.h>
 #include <rdma/rdma_cma.h>
-#include "infiniband/sa-kern-abi.h"
 
+#include "ibwrapper.h"
 #include "ibwrapper_internal.h"
-#include "lib/util/dlinklist.h"
 
 #define IBW_LASTERR_BUFSIZE 512
 static char ibw_lasterr[IBW_LASTERR_BUFSIZE];
@@ -52,8 +47,8 @@ static char ibw_lasterr[IBW_LASTERR_BUFSIZE];
 #define IBW_RECV_BUFSIZE 256
 #define IBW_RECV_THRESHOLD (1 * 1024 * 1024)
 
-static void ibw_event_handler_verbs(struct event_context *ev,
-       struct fd_event *fde, uint16_t flags, void *private_data);
+static void ibw_event_handler_verbs(struct tevent_context *ev,
+       struct tevent_fd *fde, uint16_t flags, void *private_data);
 static int ibw_fill_cq(struct ibw_conn *conn);
 static int ibw_wc_recv(struct ibw_conn *conn, struct ibv_wc *wc);
 static int ibw_wc_send(struct ibw_conn *conn, struct ibv_wc *wc);
@@ -64,7 +59,7 @@ static void *ibw_alloc_mr(struct ibw_ctx_priv *pctx, struct ibw_conn_priv *pconn
 {
        void *buf;
 
-       DEBUG(10, ("ibw_alloc_mr(cmid=%p, n=%u)\n", pconn->cm_id, n));
+       DEBUG(DEBUG_DEBUG, ("ibw_alloc_mr(cmid=%p, n=%u)\n", pconn->cm_id, n));
        buf = memalign(pctx->pagesize, n);
        if (!buf) {
                sprintf(ibw_lasterr, "couldn't allocate memory\n");
@@ -83,7 +78,7 @@ static void *ibw_alloc_mr(struct ibw_ctx_priv *pctx, struct ibw_conn_priv *pconn
 
 static void ibw_free_mr(char **ppbuf, struct ibv_mr **ppmr)
 {
-       DEBUG(10, ("ibw_free_mr(%u %u)\n", (uint32_t)*ppbuf, (uint32_t)*ppmr));
+       DEBUG(DEBUG_DEBUG, ("ibw_free_mr(%p %p)\n", *ppbuf, *ppmr));
        if (*ppmr!=NULL) {
                ibv_dereg_mr(*ppmr);
                *ppmr = NULL;
@@ -102,7 +97,7 @@ static int ibw_init_memory(struct ibw_conn *conn)
        int     i;
        struct ibw_wr   *p;
 
-       DEBUG(10, ("ibw_init_memory(cmid: %p)\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_init_memory(cmid: %p)\n", pconn->cm_id));
        pconn->buf_send = ibw_alloc_mr(pctx, pconn,
                opts->max_send_wr * opts->recv_bufsize, &pconn->mr_send);
        if (!pconn->buf_send) {
@@ -133,18 +128,18 @@ static int ibw_init_memory(struct ibw_conn *conn)
 
 static int ibw_ctx_priv_destruct(struct ibw_ctx_priv *pctx)
 {
-       DEBUG(10, ("ibw_ctx_priv_destruct(%u)\n", (uint32_t)pctx));
+       DEBUG(DEBUG_DEBUG, ("ibw_ctx_priv_destruct(%p)\n", pctx));
+
+       /*
+        * tevent_fd must be removed before the fd is closed
+        */
+       TALLOC_FREE(pctx->cm_channel_event);
 
        /* destroy cm */
        if (pctx->cm_channel) {
                rdma_destroy_event_channel(pctx->cm_channel);
                pctx->cm_channel = NULL;
        }
-       if (pctx->cm_channel_event) {
-               /* TODO: do we have to do this here? */
-               talloc_free(pctx->cm_channel_event);
-               pctx->cm_channel_event = NULL;
-       }
        if (pctx->cm_id) {
                rdma_destroy_id(pctx->cm_id);
                pctx->cm_id = NULL;
@@ -155,18 +150,23 @@ static int ibw_ctx_priv_destruct(struct ibw_ctx_priv *pctx)
 
 static int ibw_ctx_destruct(struct ibw_ctx *ctx)
 {
-       DEBUG(10, ("ibw_ctx_destruct(%u)\n", (uint32_t)ctx));
+       DEBUG(DEBUG_DEBUG, ("ibw_ctx_destruct(%p)\n", ctx));
        return 0;
 }
 
 static int ibw_conn_priv_destruct(struct ibw_conn_priv *pconn)
 {
-       DEBUG(10, ("ibw_conn_priv_destruct(%p, cmid: %p)\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_conn_priv_destruct(%p, cmid: %p)\n",
                pconn, pconn->cm_id));
 
        /* pconn->wr_index is freed by talloc */
        /* pconn->wr_index[i] are freed by talloc */
 
+       /*
+        * tevent_fd must be removed before the fd is closed
+        */
+       TALLOC_FREE(pconn->verbs_channel_event);
+
        /* destroy verbs */
        if (pconn->cm_id!=NULL && pconn->cm_id->qp!=NULL) {
                rdma_destroy_qp(pconn->cm_id);
@@ -183,12 +183,6 @@ static int ibw_conn_priv_destruct(struct ibw_conn_priv *pconn)
                pconn->verbs_channel = NULL;
        }
 
-       /* must be freed here because its order is important */
-       if (pconn->verbs_channel_event) {
-               talloc_free(pconn->verbs_channel_event);
-               pconn->verbs_channel_event = NULL;
-       }
-
        /* free memory regions */
        ibw_free_mr(&pconn->buf_send, &pconn->mr_send);
        ibw_free_mr(&pconn->buf_recv, &pconn->mr_recv);
@@ -196,13 +190,13 @@ static int ibw_conn_priv_destruct(struct ibw_conn_priv *pconn)
        if (pconn->pd) {
                ibv_dealloc_pd(pconn->pd);
                pconn->pd = NULL;
-               DEBUG(10, ("pconn=%p pd deallocated\n", pconn));
+               DEBUG(DEBUG_DEBUG, ("pconn=%p pd deallocated\n", pconn));
        }
 
        if (pconn->cm_id) {
                rdma_destroy_id(pconn->cm_id);
                pconn->cm_id = NULL;
-               DEBUG(10, ("pconn=%p cm_id destroyed\n", pconn));
+               DEBUG(DEBUG_DEBUG, ("pconn=%p cm_id destroyed\n", pconn));
        }
 
        return 0;
@@ -217,7 +211,7 @@ static int ibw_wr_destruct(struct ibw_wr *wr)
 
 static int ibw_conn_destruct(struct ibw_conn *conn)
 {
-       DEBUG(10, ("ibw_conn_destruct(%u)\n", (uint32_t)conn));
+       DEBUG(DEBUG_DEBUG, ("ibw_conn_destruct(%p)\n", conn));
        
        /* important here: ctx is a talloc _parent_ */
        DLIST_REMOVE(conn->ctx->conn_list, conn);
@@ -255,7 +249,7 @@ static int ibw_setup_cq_qp(struct ibw_conn *conn)
        struct ibv_qp_attr attr;
        int rc;
 
-       DEBUG(10, ("ibw_setup_cq_qp(cmid: %p)\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_setup_cq_qp(cmid: %p)\n", pconn->cm_id));
 
        /* init verbs */
        pconn->verbs_channel = ibv_create_comp_channel(pconn->cm_id->verbs);
@@ -263,17 +257,17 @@ static int ibw_setup_cq_qp(struct ibw_conn *conn)
                sprintf(ibw_lasterr, "ibv_create_comp_channel failed %d\n", errno);
                return -1;
        }
-       DEBUG(10, ("created channel %p\n", pconn->verbs_channel));
+       DEBUG(DEBUG_DEBUG, ("created channel %p\n", pconn->verbs_channel));
 
-       pconn->verbs_channel_event = event_add_fd(pctx->ectx, NULL, /* not pconn or conn */
-               pconn->verbs_channel->fd, EVENT_FD_READ, ibw_event_handler_verbs, conn);
+       pconn->verbs_channel_event = tevent_add_fd(pctx->ectx, NULL, /* not pconn or conn */
+               pconn->verbs_channel->fd, TEVENT_FD_READ, ibw_event_handler_verbs, conn);
 
        pconn->pd = ibv_alloc_pd(pconn->cm_id->verbs);
        if (!pconn->pd) {
                sprintf(ibw_lasterr, "ibv_alloc_pd failed %d\n", errno);
                return -1;
        }
-       DEBUG(10, ("created pd %p\n", pconn->pd));
+       DEBUG(DEBUG_DEBUG, ("created pd %p\n", pconn->pd));
 
        /* init mr */
        if (ibw_init_memory(conn))
@@ -337,7 +331,7 @@ static int ibw_refill_cq_recv(struct ibw_conn *conn)
        };
        struct ibv_recv_wr *bad_wr;
 
-       DEBUG(10, ("ibw_refill_cq_recv(cmid: %p)\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_refill_cq_recv(cmid: %p)\n", pconn->cm_id));
 
        list.addr = (uintptr_t) pconn->buf_recv + pctx->opts.recv_bufsize * pconn->recv_index;
        wr.wr_id = pconn->recv_index;
@@ -346,7 +340,7 @@ static int ibw_refill_cq_recv(struct ibw_conn *conn)
        rc = ibv_post_recv(pconn->cm_id->qp, &wr, &bad_wr);
        if (rc) {
                sprintf(ibw_lasterr, "refill/ibv_post_recv failed with %d\n", rc);
-               DEBUG(0, (ibw_lasterr));
+               DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                return -2;
        }
 
@@ -370,7 +364,7 @@ static int ibw_fill_cq(struct ibw_conn *conn)
        };
        struct ibv_recv_wr *bad_wr;
 
-       DEBUG(10, ("ibw_fill_cq(cmid: %p)\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_fill_cq(cmid: %p)\n", pconn->cm_id));
 
        for(i = pctx->opts.max_recv_wr; i!=0; i--) {
                list.addr = (uintptr_t) pconn->buf_recv + pctx->opts.recv_bufsize * pconn->recv_index;
@@ -380,7 +374,7 @@ static int ibw_fill_cq(struct ibw_conn *conn)
                rc = ibv_post_recv(pconn->cm_id->qp, &wr, &bad_wr);
                if (rc) {
                        sprintf(ibw_lasterr, "fill/ibv_post_recv failed with %d\n", rc);
-                       DEBUG(0, (ibw_lasterr));
+                       DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                        return -2;
                }
        }
@@ -394,7 +388,7 @@ static int ibw_manage_connect(struct ibw_conn *conn)
        struct ibw_conn_priv *pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
        int     rc;
 
-       DEBUG(10, ("ibw_manage_connect(cmid: %p)\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_manage_connect(cmid: %p)\n", pconn->cm_id));
 
        if (ibw_setup_cq_qp(conn))
                return -1;
@@ -412,8 +406,8 @@ static int ibw_manage_connect(struct ibw_conn *conn)
        return rc;
 }
 
-static void ibw_event_handler_cm(struct event_context *ev,
-       struct fd_event *fde, uint16_t flags, void *private_data)
+static void ibw_event_handler_cm(struct tevent_context *ev,
+       struct tevent_fd *fde, uint16_t flags, void *private_data)
 {
        int     rc;
        struct ibw_ctx  *ctx = talloc_get_type(private_data, struct ibw_ctx);
@@ -428,17 +422,18 @@ static void ibw_event_handler_cm(struct event_context *ev,
        rc = rdma_get_cm_event(pctx->cm_channel, &event);
        if (rc) {
                ctx->state = IBWS_ERROR;
+               event = NULL;
                sprintf(ibw_lasterr, "rdma_get_cm_event error %d\n", rc);
                goto error;
        }
        cma_id = event->id;
 
-       DEBUG(10, ("cma_event type %d cma_id %p (%s)\n", event->event, cma_id,
+       DEBUG(DEBUG_DEBUG, ("cma_event type %d cma_id %p (%s)\n", event->event, cma_id,
                  (cma_id == pctx->cm_id) ? "parent" : "child"));
 
        switch (event->event) {
        case RDMA_CM_EVENT_ADDR_RESOLVED:
-               DEBUG(11, ("RDMA_CM_EVENT_ADDR_RESOLVED\n"));
+               DEBUG(DEBUG_DEBUG, ("RDMA_CM_EVENT_ADDR_RESOLVED\n"));
                /* continuing from ibw_connect ... */
                rc = rdma_resolve_route(cma_id, 2000);
                if (rc) {
@@ -449,7 +444,7 @@ static void ibw_event_handler_cm(struct event_context *ev,
                break;
 
        case RDMA_CM_EVENT_ROUTE_RESOLVED:
-               DEBUG(11, ("RDMA_CM_EVENT_ROUTE_RESOLVED\n"));
+               DEBUG(DEBUG_DEBUG, ("RDMA_CM_EVENT_ROUTE_RESOLVED\n"));
                /* after RDMA_CM_EVENT_ADDR_RESOLVED: */
                assert(cma_id->context!=NULL);
                conn = talloc_get_type(cma_id->context, struct ibw_conn);
@@ -461,13 +456,13 @@ static void ibw_event_handler_cm(struct event_context *ev,
                break;
 
        case RDMA_CM_EVENT_CONNECT_REQUEST:
-               DEBUG(11, ("RDMA_CM_EVENT_CONNECT_REQUEST\n"));
+               DEBUG(DEBUG_DEBUG, ("RDMA_CM_EVENT_CONNECT_REQUEST\n"));
                ctx->state = IBWS_CONNECT_REQUEST;
                conn = ibw_conn_new(ctx, ctx);
                pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
                pconn->cm_id = cma_id; /* !!! event will be freed but id not */
                cma_id->context = (void *)conn;
-               DEBUG(10, ("pconn->cm_id %p\n", pconn->cm_id));
+               DEBUG(DEBUG_DEBUG, ("pconn->cm_id %p\n", pconn->cm_id));
 
                if (ibw_setup_cq_qp(conn))
                        goto error;
@@ -479,9 +474,9 @@ static void ibw_event_handler_cm(struct event_context *ev,
                if (!pconn->is_accepted) {
                        rc = rdma_reject(cma_id, NULL, 0);
                        if (rc)
-                               DEBUG(0, ("rdma_reject failed with rc=%d\n", rc));
+                               DEBUG(DEBUG_ERR, ("rdma_reject failed with rc=%d\n", rc));
                        talloc_free(conn);
-                       DEBUG(10, ("pconn->cm_id %p wasn't accepted\n", pconn->cm_id));
+                       DEBUG(DEBUG_DEBUG, ("pconn->cm_id %p wasn't accepted\n", pconn->cm_id));
                }
 
                /* TODO: clarify whether if it's needed by upper layer: */
@@ -493,11 +488,11 @@ static void ibw_event_handler_cm(struct event_context *ev,
 
        case RDMA_CM_EVENT_ESTABLISHED:
                /* expected after ibw_accept and ibw_connect[not directly] */
-               DEBUG(0, ("ESTABLISHED (conn: %p)\n", cma_id->context));
+               DEBUG(DEBUG_INFO, ("ESTABLISHED (conn: %p)\n", cma_id->context));
                conn = talloc_get_type(cma_id->context, struct ibw_conn);
                assert(conn!=NULL); /* important assumption */
 
-               DEBUG(10, ("ibw_setup_cq_qp succeeded (cmid=%p)\n", cma_id));
+               DEBUG(DEBUG_DEBUG, ("ibw_setup_cq_qp succeeded (cmid=%p)\n", cma_id));
 
                /* client conn is up */
                conn->state = IBWC_CONNECTED;
@@ -514,26 +509,30 @@ static void ibw_event_handler_cm(struct event_context *ev,
                sprintf(ibw_lasterr, "RDMA_CM_EVENT_CONNECT_ERROR, error %d\n", event->status);
        case RDMA_CM_EVENT_UNREACHABLE:
                sprintf(ibw_lasterr, "RDMA_CM_EVENT_UNREACHABLE, error %d\n", event->status);
+               goto error;
        case RDMA_CM_EVENT_REJECTED:
                sprintf(ibw_lasterr, "RDMA_CM_EVENT_REJECTED, error %d\n", event->status);
+               DEBUG(DEBUG_INFO, ("cm event handler: %s", ibw_lasterr));
                conn = talloc_get_type(cma_id->context, struct ibw_conn);
                if (conn) {
+                       /* must be done BEFORE connstate */
                        if ((rc=rdma_ack_cm_event(event)))
-                               DEBUG(0, ("reject/rdma_ack_cm_event failed with %d\n", rc));
-                       event = NULL;
-                       pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
-                       ibw_conn_priv_destruct(pconn);
+                               DEBUG(DEBUG_ERR, ("reject/rdma_ack_cm_event failed with %d\n", rc));
+                       event = NULL; /* not to touch cma_id or conn */
+                       conn->state = IBWC_ERROR;
+                       /* it should free the conn */
+                       pctx->connstate_func(NULL, conn);
                }
-               goto error;
+               break; /* this is not strictly an error */
 
        case RDMA_CM_EVENT_DISCONNECTED:
-               DEBUG(11, ("RDMA_CM_EVENT_DISCONNECTED\n"));
+               DEBUG(DEBUG_DEBUG, ("RDMA_CM_EVENT_DISCONNECTED\n"));
                if ((rc=rdma_ack_cm_event(event)))
-                       DEBUG(0, ("disc/rdma_ack_cm_event failed with %d\n", rc));
+                       DEBUG(DEBUG_ERR, ("disc/rdma_ack_cm_event failed with %d\n", rc));
                event = NULL; /* don't ack more */
 
                if (cma_id!=pctx->cm_id) {
-                       DEBUG(0, ("client DISCONNECT event cm_id=%p\n", cma_id));
+                       DEBUG(DEBUG_ERR, ("client DISCONNECT event cm_id=%p\n", cma_id));
                        conn = talloc_get_type(cma_id->context, struct ibw_conn);
                        conn->state = IBWC_DISCONNECTED;
                        pctx->connstate_func(NULL, conn);
@@ -556,26 +555,30 @@ static void ibw_event_handler_cm(struct event_context *ev,
 
        return;
 error:
-       if (event!=NULL && (rc=rdma_ack_cm_event(event))) {
-               sprintf(ibw_lasterr, "rdma_ack_cm_event failed with %d\n", rc);
-               goto error;
-       }
+       DEBUG(DEBUG_ERR, ("cm event handler: %s", ibw_lasterr));
 
-       DEBUG(0, ("cm event handler: %s", ibw_lasterr));
+       if (event!=NULL) {
+               if (cma_id!=NULL && cma_id!=pctx->cm_id) {
+                       conn = talloc_get_type(cma_id->context, struct ibw_conn);
+                       if (conn) {
+                               conn->state = IBWC_ERROR;
+                               pctx->connstate_func(NULL, conn);
+                       }
+               } else {
+                       ctx->state = IBWS_ERROR;
+                       pctx->connstate_func(ctx, NULL);
+               }
 
-       if (cma_id!=pctx->cm_id) {
-               conn = talloc_get_type(cma_id->context, struct ibw_conn);
-               if (conn)
-                       conn->state = IBWC_ERROR;
-               pctx->connstate_func(NULL, conn);
-       } else {
-               ctx->state = IBWS_ERROR;
-               pctx->connstate_func(ctx, NULL);
+               if ((rc=rdma_ack_cm_event(event))!=0) {
+                       DEBUG(DEBUG_ERR, ("rdma_ack_cm_event failed with %d\n", rc));
+               }
        }
+
+       return;
 }
 
-static void ibw_event_handler_verbs(struct event_context *ev,
-       struct fd_event *fde, uint16_t flags, void *private_data)
+static void ibw_event_handler_verbs(struct tevent_context *ev,
+       struct tevent_fd *fde, uint16_t flags, void *private_data)
 {
        struct ibw_conn *conn = talloc_get_type(private_data, struct ibw_conn);
        struct ibw_conn_priv *pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
@@ -586,7 +589,7 @@ static void ibw_event_handler_verbs(struct event_context *ev,
        struct ibv_cq *ev_cq;
        void          *ev_ctx;
 
-       DEBUG(10, ("ibw_event_handler_verbs(%u)\n", (uint32_t)flags));
+       DEBUG(DEBUG_DEBUG, ("ibw_event_handler_verbs(%u)\n", (uint32_t)flags));
 
        /* TODO: check whether if it's good to have more channels here... */
        rc = ibv_get_cq_event(pconn->verbs_channel, &ev_cq, &ev_ctx);
@@ -613,21 +616,21 @@ static void ibw_event_handler_verbs(struct event_context *ev,
 
                switch(wc.opcode) {
                case IBV_WC_SEND:
-                       DEBUG(10, ("send completion\n"));
+                       DEBUG(DEBUG_DEBUG, ("send completion\n"));
                        if (ibw_wc_send(conn, &wc))
                                goto error;
                        break;
 
                case IBV_WC_RDMA_WRITE:
-                       DEBUG(10, ("rdma write completion\n"));
+                       DEBUG(DEBUG_DEBUG, ("rdma write completion\n"));
                        break;
        
                case IBV_WC_RDMA_READ:
-                       DEBUG(10, ("rdma read completion\n"));
+                       DEBUG(DEBUG_DEBUG, ("rdma read completion\n"));
                        break;
 
                case IBV_WC_RECV:
-                       DEBUG(10, ("recv completion\n"));
+                       DEBUG(DEBUG_DEBUG, ("recv completion\n"));
                        if (ibw_wc_recv(conn, &wc))
                                goto error;
                        break;
@@ -648,7 +651,7 @@ static void ibw_event_handler_verbs(struct event_context *ev,
 error:
        ibv_ack_cq_events(pconn->cq, 1);
 
-       DEBUG(0, (ibw_lasterr));
+       DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
        
        if (conn->state!=IBWC_ERROR) {
                conn->state = IBWC_ERROR;
@@ -679,7 +682,7 @@ static int ibw_process_queue(struct ibw_conn *conn)
        assert(p->queued_msg!=NULL);
        assert(msg_size!=0);
 
-       DEBUG(10, ("ibw_process_queue refcnt=%d msgsize=%u\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_process_queue refcnt=%d msgsize=%u\n",
                p->queued_ref_cnt, msg_size));
 
        rc = ibw_send_packet(conn, p->queued_msg, p, msg_size);
@@ -702,7 +705,7 @@ static int ibw_wc_send(struct ibw_conn *conn, struct ibv_wc *wc)
        struct ibw_wr   *p;
        int     send_index;
 
-       DEBUG(10, ("ibw_wc_send(cmid: %p, wr_id: %u, bl: %u)\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_wc_send(cmid: %p, wr_id: %u, bl: %u)\n",
                pconn->cm_id, (uint32_t)wc->wr_id, (uint32_t)wc->byte_len));
 
        assert(pconn->cm_id->qp->qp_num==wc->qp_num);
@@ -711,7 +714,7 @@ static int ibw_wc_send(struct ibw_conn *conn, struct ibv_wc *wc)
        pconn->wr_sent--;
 
        if (send_index < pctx->opts.max_send_wr) {
-               DEBUG(10, ("ibw_wc_send#1 %u\n", (int)wc->wr_id));
+               DEBUG(DEBUG_DEBUG, ("ibw_wc_send#1 %u\n", (int)wc->wr_id));
                p = pconn->wr_index[send_index];
                if (p->buf_large!=NULL) {
                        if (p->ref_cnt) {
@@ -727,7 +730,7 @@ static int ibw_wc_send(struct ibw_conn *conn, struct ibv_wc *wc)
                        DLIST_ADD(pconn->wr_list_avail, p);
                }
        } else { /* "extra" request - not optimized */
-               DEBUG(10, ("ibw_wc_send#2 %u\n", (int)wc->wr_id));
+               DEBUG(DEBUG_DEBUG, ("ibw_wc_send#2 %u\n", (int)wc->wr_id));
                for(p=pconn->extra_sent; p!=NULL; p=p->next)
                        if ((p->wr_id + pctx->opts.max_recv_wr)==(int)wc->wr_id)
                                break;
@@ -750,7 +753,7 @@ static int ibw_wc_send(struct ibw_conn *conn, struct ibv_wc *wc)
 static int ibw_append_to_part(struct ibw_conn_priv *pconn,
        struct ibw_part *part, char **pp, uint32_t add_len, int info)
 {
-       DEBUG(10, ("ibw_append_to_part: cmid=%p, (bs=%u, len=%u, tr=%u), al=%u, i=%u\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_append_to_part: cmid=%p, (bs=%u, len=%u, tr=%u), al=%u, i=%u\n",
                pconn->cm_id, part->bufsize, part->len, part->to_read, add_len, info));
 
        /* allocate more if necessary - it's an "evergrowing" buffer... */
@@ -788,11 +791,11 @@ static int ibw_append_to_part(struct ibw_conn_priv *pconn,
 static int ibw_wc_mem_threshold(struct ibw_conn_priv *pconn,
        struct ibw_part *part, uint32_t threshold)
 {
-       DEBUG(10, ("ibw_wc_mem_threshold: cmid=%p, (bs=%u, len=%u, tr=%u), thr=%u\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_wc_mem_threshold: cmid=%p, (bs=%u, len=%u, tr=%u), thr=%u\n",
                pconn->cm_id, part->bufsize, part->len, part->to_read, threshold));
 
        if (part->bufsize > threshold) {
-               DEBUG(3, ("ibw_wc_mem_threshold: cmid=%p, %u > %u\n",
+               DEBUG(DEBUG_DEBUG, ("ibw_wc_mem_threshold: cmid=%p, %u > %u\n",
                        pconn->cm_id, part->bufsize, threshold));
                talloc_free(part->buf);
                part->buf = talloc_size(pconn, threshold);
@@ -813,7 +816,7 @@ static int ibw_wc_recv(struct ibw_conn *conn, struct ibv_wc *wc)
        char    *p;
        uint32_t        remain = wc->byte_len;
 
-       DEBUG(10, ("ibw_wc_recv: cmid=%p, wr_id: %u, bl: %u\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_wc_recv: cmid=%p, wr_id: %u, bl: %u\n",
                pconn->cm_id, (uint32_t)wc->wr_id, remain));
 
        assert(pconn->cm_id->qp->qp_num==wc->qp_num);
@@ -843,7 +846,9 @@ static int ibw_wc_recv(struct ibw_conn *conn, struct ibv_wc *wc)
                        }
 
                        if (part->to_read==0) {
-                               pctx->receive_func(conn, part->buf, part->len);
+                               if (pctx->receive_func(conn, part->buf, part->len) != 0) {
+                                       goto error;
+                               }
                                part->len = 0; /* tells not having partial data (any more) */
                                if (ibw_wc_mem_threshold(pconn, part, pctx->opts.recv_threshold))
                                        goto error;
@@ -858,7 +863,9 @@ static int ibw_wc_recv(struct ibw_conn *conn, struct ibv_wc *wc)
 
                                /* mostly awaited case: */
                                if (msglen<=remain) {
-                                       pctx->receive_func(conn, p, msglen);
+                                       if (pctx->receive_func(conn, p, msglen) != 0) {
+                                               goto error;
+                                       }
                                        p += msglen;
                                        remain -= msglen;
                                } else {
@@ -886,7 +893,7 @@ static int ibw_wc_recv(struct ibw_conn *conn, struct ibv_wc *wc)
        return 0;
 
 error:
-       DEBUG(0, ("ibw_wc_recv error: %s", ibw_lasterr));
+       DEBUG(DEBUG_ERR, ("ibw_wc_recv error: %s", ibw_lasterr));
        return -1;
 }
 
@@ -895,7 +902,7 @@ static int ibw_process_init_attrs(struct ibw_initattr *attr, int nattr, struct i
        int     i;
        const char *name, *value;
 
-       DEBUG(10, ("ibw_process_init_attrs: nattr: %d\n", nattr));
+       DEBUG(DEBUG_DEBUG, ("ibw_process_init_attrs: nattr: %d\n", nattr));
 
        opts->max_send_wr = IBW_MAX_SEND_WR;
        opts->max_recv_wr = IBW_MAX_RECV_WR;
@@ -927,13 +934,13 @@ struct ibw_ctx *ibw_init(struct ibw_initattr *attr, int nattr,
        void *ctx_userdata,
        ibw_connstate_fn_t ibw_connstate,
        ibw_receive_fn_t ibw_receive,
-       struct event_context *ectx)
+       struct tevent_context *ectx)
 {
        struct ibw_ctx *ctx = talloc_zero(NULL, struct ibw_ctx);
        struct ibw_ctx_priv *pctx;
        int     rc;
 
-       DEBUG(10, ("ibw_init(ctx_userdata: %p, ectx: %p)\n", ctx_userdata, ectx));
+       DEBUG(DEBUG_DEBUG, ("ibw_init(ctx_userdata: %p, ectx: %p)\n", ctx_userdata, ectx));
 
        /* initialize basic data structures */
        memset(ibw_lasterr, 0, IBW_LASTERR_BUFSIZE);
@@ -964,23 +971,27 @@ struct ibw_ctx *ibw_init(struct ibw_initattr *attr, int nattr,
                goto cleanup;
        }
 
-       pctx->cm_channel_event = event_add_fd(pctx->ectx, pctx,
-               pctx->cm_channel->fd, EVENT_FD_READ, ibw_event_handler_cm, ctx);
+       pctx->cm_channel_event = tevent_add_fd(pctx->ectx, pctx,
+               pctx->cm_channel->fd, TEVENT_FD_READ, ibw_event_handler_cm, ctx);
 
+#if RDMA_USER_CM_MAX_ABI_VERSION >= 2
        rc = rdma_create_id(pctx->cm_channel, &pctx->cm_id, ctx, RDMA_PS_TCP);
+#else
+       rc = rdma_create_id(pctx->cm_channel, &pctx->cm_id, ctx);
+#endif
        if (rc) {
                rc = errno;
                sprintf(ibw_lasterr, "rdma_create_id error %d\n", rc);
                goto cleanup;
        }
-       DEBUG(10, ("created cm_id %p\n", pctx->cm_id));
+       DEBUG(DEBUG_DEBUG, ("created cm_id %p\n", pctx->cm_id));
 
        pctx->pagesize = sysconf(_SC_PAGESIZE);
 
        return ctx;
        /* don't put code here */
 cleanup:
-       DEBUG(0, (ibw_lasterr));
+       DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
 
        if (ctx)
                talloc_free(ctx);
@@ -993,10 +1004,10 @@ int ibw_stop(struct ibw_ctx *ctx)
        struct ibw_ctx_priv *pctx = (struct ibw_ctx_priv *)ctx->internal;
        struct ibw_conn *p;
 
-       DEBUG(10, ("ibw_stop\n"));
+       DEBUG(DEBUG_DEBUG, ("ibw_stop\n"));
 
        for(p=ctx->conn_list; p!=NULL; p=p->next) {
-               if (ctx->state==IBWC_ERROR || ctx->state==IBWC_CONNECTED) {
+               if (p->state==IBWC_ERROR || p->state==IBWC_CONNECTED) {
                        if (ibw_disconnect(p))
                                return -1;
                }
@@ -1013,15 +1024,15 @@ int ibw_bind(struct ibw_ctx *ctx, struct sockaddr_in *my_addr)
        struct ibw_ctx_priv *pctx = (struct ibw_ctx_priv *)ctx->internal;
        int     rc;
 
-       DEBUG(10, ("ibw_bind: addr=%s, port=%u\n",
+       DEBUG(DEBUG_DEBUG, ("ibw_bind: addr=%s, port=%u\n",
                inet_ntoa(my_addr->sin_addr), ntohs(my_addr->sin_port)));
        rc = rdma_bind_addr(pctx->cm_id, (struct sockaddr *) my_addr);
        if (rc) {
                sprintf(ibw_lasterr, "rdma_bind_addr error %d\n", rc);
-               DEBUG(0, (ibw_lasterr));
+               DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                return rc;
        }
-       DEBUG(10, ("rdma_bind_addr successful\n"));
+       DEBUG(DEBUG_DEBUG, ("rdma_bind_addr successful\n"));
 
        return 0;
 }
@@ -1031,11 +1042,11 @@ int ibw_listen(struct ibw_ctx *ctx, int backlog)
        struct ibw_ctx_priv *pctx = talloc_get_type(ctx->internal, struct ibw_ctx_priv);
        int     rc;
 
-       DEBUG(10, ("ibw_listen\n"));
+       DEBUG(DEBUG_DEBUG, ("ibw_listen\n"));
        rc = rdma_listen(pctx->cm_id, backlog);
        if (rc) {
                sprintf(ibw_lasterr, "rdma_listen failed: %d\n", rc);
-               DEBUG(0, (ibw_lasterr));
+               DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                return rc;
        }
 
@@ -1048,7 +1059,7 @@ int ibw_accept(struct ibw_ctx *ctx, struct ibw_conn *conn, void *conn_userdata)
        struct rdma_conn_param  conn_param;
        int     rc;
 
-       DEBUG(10, ("ibw_accept: cmid=%p\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_accept: cmid=%p\n", pconn->cm_id));
        conn->conn_userdata = conn_userdata;
 
        memset(&conn_param, 0, sizeof(struct rdma_conn_param));
@@ -1057,7 +1068,7 @@ int ibw_accept(struct ibw_ctx *ctx, struct ibw_conn *conn, void *conn_userdata)
        rc = rdma_accept(pconn->cm_id, &conn_param);
        if (rc) {
                sprintf(ibw_lasterr, "rdma_accept failed %d\n", rc);
-               DEBUG(0, (ibw_lasterr));
+               DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                return -1;;
        }
 
@@ -1078,29 +1089,33 @@ int ibw_connect(struct ibw_conn *conn, struct sockaddr_in *serv_addr, void *conn
 
        conn->conn_userdata = conn_userdata;
        pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
-       DEBUG(10, ("ibw_connect: addr=%s, port=%u\n", inet_ntoa(serv_addr->sin_addr),
+       DEBUG(DEBUG_DEBUG, ("ibw_connect: addr=%s, port=%u\n", inet_ntoa(serv_addr->sin_addr),
                ntohs(serv_addr->sin_port)));
 
        /* clean previous - probably half - initialization */
        if (ibw_conn_priv_destruct(pconn)) {
-               DEBUG(0, ("ibw_connect/ibw_pconn_destruct failed for cm_id=%p\n", pconn->cm_id));
+               DEBUG(DEBUG_ERR, ("ibw_connect/ibw_pconn_destruct failed for cm_id=%p\n", pconn->cm_id));
                return -1;
        }
 
        /* init cm */
+#if RDMA_USER_CM_MAX_ABI_VERSION >= 2
        rc = rdma_create_id(pctx->cm_channel, &pconn->cm_id, conn, RDMA_PS_TCP);
+#else
+       rc = rdma_create_id(pctx->cm_channel, &pconn->cm_id, conn);
+#endif
        if (rc) {
                rc = errno;
                sprintf(ibw_lasterr, "ibw_connect/rdma_create_id error %d\n", rc);
                talloc_free(conn);
                return -1;
        }
-       DEBUG(10, ("ibw_connect: rdma_create_id succeeded, cm_id=%p\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_connect: rdma_create_id succeeded, cm_id=%p\n", pconn->cm_id));
 
        rc = rdma_resolve_addr(pconn->cm_id, NULL, (struct sockaddr *) serv_addr, 2000);
        if (rc) {
                sprintf(ibw_lasterr, "rdma_resolve_addr error %d\n", rc);
-               DEBUG(0, (ibw_lasterr));
+               DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                talloc_free(conn);
                return -1;
        }
@@ -1115,7 +1130,7 @@ int ibw_disconnect(struct ibw_conn *conn)
        int     rc;
        struct ibw_conn_priv *pconn = talloc_get_type(conn->internal, struct ibw_conn_priv);
 
-       DEBUG(10, ("ibw_disconnect: cmid=%p\n", pconn->cm_id));
+       DEBUG(DEBUG_DEBUG, ("ibw_disconnect: cmid=%p\n", pconn->cm_id));
 
        assert(pconn!=NULL);
 
@@ -1127,12 +1142,12 @@ int ibw_disconnect(struct ibw_conn *conn)
                rc = rdma_disconnect(pconn->cm_id);
                if (rc) {
                        sprintf(ibw_lasterr, "ibw_disconnect failed with %d\n", rc);
-                       DEBUG(0, (ibw_lasterr));
+                       DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
                        return rc;
                }
                break;
        default:
-               DEBUG(9, ("invalid state for disconnect: %d\n", conn->state));
+               DEBUG(DEBUG_DEBUG, ("invalid state for disconnect: %d\n", conn->state));
                break;
        }
 
@@ -1146,7 +1161,7 @@ int ibw_alloc_send_buf(struct ibw_conn *conn, void **buf, void **key, uint32_t l
        struct ibw_wr *p = pconn->wr_list_avail;
 
        if (p!=NULL) {
-               DEBUG(10, ("ibw_alloc_send_buf#1: cmid=%p, len=%d\n", pconn->cm_id, len));
+               DEBUG(DEBUG_DEBUG, ("ibw_alloc_send_buf#1: cmid=%p, len=%d\n", pconn->cm_id, len));
 
                DLIST_REMOVE(pconn->wr_list_avail, p);
                DLIST_ADD(pconn->wr_list_used, p);
@@ -1163,7 +1178,7 @@ int ibw_alloc_send_buf(struct ibw_conn *conn, void **buf, void **key, uint32_t l
                }
                /* p->wr_id is already filled in ibw_init_memory */
        } else {
-               DEBUG(10, ("ibw_alloc_send_buf#2: cmid=%p, len=%d\n", pconn->cm_id, len));
+               DEBUG(DEBUG_DEBUG, ("ibw_alloc_send_buf#2: cmid=%p, len=%d\n", pconn->cm_id, len));
                /* not optimized */
                p = pconn->extra_avail;
                if (!p) {
@@ -1176,10 +1191,10 @@ int ibw_alloc_send_buf(struct ibw_conn *conn, void **buf, void **key, uint32_t l
                        p->wr_id = pctx->opts.max_send_wr + pconn->extra_max;
                        pconn->extra_max++;
                        switch(pconn->extra_max) {
-                               case 1: DEBUG(2, ("warning: queue performed\n")); break;
-                               case 10: DEBUG(0, ("warning: queue reached 10\n")); break;
-                               case 100: DEBUG(0, ("warning: queue reached 100\n")); break;
-                               case 1000: DEBUG(0, ("warning: queue reached 1000\n")); break;
+                               case 1: DEBUG(DEBUG_INFO, ("warning: queue performed\n")); break;
+                               case 10: DEBUG(DEBUG_INFO, ("warning: queue reached 10\n")); break;
+                               case 100: DEBUG(DEBUG_INFO, ("warning: queue reached 100\n")); break;
+                               case 1000: DEBUG(DEBUG_INFO, ("warning: queue reached 1000\n")); break;
                                default: break;
                        }
                }
@@ -1201,7 +1216,7 @@ int ibw_alloc_send_buf(struct ibw_conn *conn, void **buf, void **key, uint32_t l
 
        return 0;
 error:
-       DEBUG(0, ("ibw_alloc_send_buf error: %s", ibw_lasterr));
+       DEBUG(DEBUG_ERR, ("ibw_alloc_send_buf error: %s", ibw_lasterr));
        return -1;
 }
 
@@ -1229,10 +1244,10 @@ static int ibw_send_packet(struct ibw_conn *conn, void *buf, struct ibw_wr *p, u
                };
 
                if (p->buf_large==NULL) {
-                       DEBUG(10, ("ibw_send#normal(cmid: %p, wrid: %u, n: %d)\n",
+                       DEBUG(DEBUG_DEBUG, ("ibw_send#normal(cmid: %p, wrid: %u, n: %d)\n",
                                pconn->cm_id, (uint32_t)wr.wr_id, len));
                } else {
-                       DEBUG(10, ("ibw_send#large(cmid: %p, wrid: %u, n: %d)\n",
+                       DEBUG(DEBUG_DEBUG, ("ibw_send#large(cmid: %p, wrid: %u, n: %d)\n",
                                pconn->cm_id, (uint32_t)wr.wr_id, len));
                        list.lkey = p->mr_large->lkey;
                }
@@ -1249,7 +1264,7 @@ static int ibw_send_packet(struct ibw_conn *conn, void *buf, struct ibw_wr *p, u
                return rc;
        } /* else put the request into our own queue: */
 
-       DEBUG(10, ("ibw_send#queued(cmid: %p, len: %u)\n", pconn->cm_id, len));
+       DEBUG(DEBUG_DEBUG, ("ibw_send#queued(cmid: %p, len: %u)\n", pconn->cm_id, len));
 
        /* TODO: clarify how to continue when state==IBWC_STOPPED */
 
@@ -1265,7 +1280,7 @@ static int ibw_send_packet(struct ibw_conn *conn, void *buf, struct ibw_wr *p, u
 
        return 0;
 error:
-       DEBUG(0, (ibw_lasterr));
+       DEBUG(DEBUG_ERR, ("%s", ibw_lasterr));
        return -1;
 }
 
@@ -1284,7 +1299,7 @@ int ibw_send(struct ibw_conn *conn, void *buf, void *key, uint32_t len)
                char    *packet = (char *)buf;
                uint32_t        recv_bufsize = pctx->opts.recv_bufsize;
 
-               DEBUG(10, ("ibw_send#frag(cmid: %p, buf: %p, len: %u)\n",
+               DEBUG(DEBUG_DEBUG, ("ibw_send#frag(cmid: %p, buf: %p, len: %u)\n",
                        pconn->cm_id, buf, len));
 
                /* single threaded => no race here: */
@@ -1326,11 +1341,11 @@ int ibw_cancel_send_buf(struct ibw_conn *conn, void *buf, void *key)
 
        /* parallel case */
        if (p->wr_id < pctx->opts.max_send_wr) {
-               DEBUG(10, ("ibw_cancel_send_buf#1 %u", (int)p->wr_id));
+               DEBUG(DEBUG_DEBUG, ("ibw_cancel_send_buf#1 %u", (int)p->wr_id));
                DLIST_REMOVE(pconn->wr_list_used, p);
                DLIST_ADD(pconn->wr_list_avail, p);
        } else { /* "extra" packet */
-               DEBUG(10, ("ibw_cancel_send_buf#2 %u", (int)p->wr_id));
+               DEBUG(DEBUG_DEBUG, ("ibw_cancel_send_buf#2 %u", (int)p->wr_id));
                DLIST_REMOVE(pconn->extra_sent, p);
                DLIST_ADD(pconn->extra_avail, p);
        }