Hi,
From the moment we send first message from client until we get ack it takes 134ms (for example), which is too long!
Why in TCP it is 10ms?
In UFA code, we send header at 13:45:14.983 and receive ack only at 13:45:15.117
Thanks, Yuriy.
Log attached:
14/01/26 13:45:14.792 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:29:Context() CTOR start
14/01/26 13:45:14.792 DEBUG LogFromNative (212) ./xio/xio_context.c:201:xio_ctx_create() statistics monitoring disabled. not priviliged user
14/01/26 13:45:14.792 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:62:Context() CTOR done
14/01/26 13:45:14.798 DEBUG LogFromNative (212) MsgPool[0x7fa5f4f0d0d0]:81:MsgPool() CTOR done. allocated msg pool: num_msgs=80, in_size=1024, out_size=66560
14/01/26 13:45:14.858 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.859 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.859 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.859 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.860 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.860 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.861 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.861 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.862 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.862 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.862 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.862 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.863 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.864 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.864 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.864 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.865 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.865 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.866 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.866 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.866 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.867 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.868 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:117:break_event_loop() before break event loop (is_self_thread=0)
14/01/26 13:45:14.868 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:119:break_event_loop() after break event loop (is_self_thread=0)
14/01/26 13:45:14.927 DEBUG LogFromNative (212) Client[0xb0f5f0]:30:Client() CTOR start
14/01/26 13:45:14.928 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1742:xio_rdma_open() xio_rdma_open: [new] handle:0xb11200
14/01/26 13:45:14.928 TRACE LogFromNative (209) ../common/xio_conn.c:1454:xio_conn_open() conn: [new] conn:0xb11030, transport_hndl:0xb11200
14/01/26 13:45:14.929 DEBUG LogFromNative (212) Client[0xb0f5f0]:69:Client() CTOR done
14/01/26 13:45:14.982 TRACE LogFromNative (209) Client[0xb0f5f0]:156:send_msg() ##################### sending msg=0x7fa5f4f0d4d0, size=133
14/01/26 13:45:14.984 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.985 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ADDR_RESOLVED] rdma_hndl:0xb11200
14/01/26 13:45:14.985 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ADDR_RESOLVED, hndl:0xb11200
14/01/26 13:45:14.985 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.987 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.988 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ROUTE_RESOLVED] rdma_hndl:0xb11200
14/01/26 13:45:14.988 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ROUTE_RESOLVED, hndl:0xb11200
14/01/26 13:45:14.989 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:293:xio_cq_init() comp_vec:0
14/01/26 13:45:14.992 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:761:xio_setup_qp() rdma qp: [new] handle:0xb11200, qp:0x409d5, max inline:448
14/01/26 13:45:14.992 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.993 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.993 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.994 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.994 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.994 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.995 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.995 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.996 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ESTABLISHED] rdma_hndl:0xb11200
14/01/26 13:45:14.996 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ESTABLISHED, hndl:0xb11200
14/01/26 13:45:14.996 DEBUG LogFromNative (212) ../common/xio_conn.c:1321:xio_on_transport_event() conn: [notification] - transport established. conn:0xb11030, transport:0xb11200
14/01/26 13:45:14.996 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1049:xio_rdma_initial_pool_run() post_recv conn_setup rx task:0xc16000
14/01/26 13:45:14.996 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:1, len1:36, len2:0, send_flags:10
14/01/26 13:45:14.996 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.997 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.997 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.998 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.998 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.999 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.999 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:14.999 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:14.999 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.000 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.000 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.001 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.001 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.002 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.002 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.003 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.003 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.003 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.003 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.004 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.004 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.005 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.005 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.006 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.006 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.006 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.006 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.007 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.007 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.008 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.008 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.008 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.009 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.009 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.009 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.010 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.010 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.011 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.011 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.011 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.011 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.012 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.012 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.013 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.013 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.014 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.014 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.014 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.014 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.015 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.015 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.016 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.016 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.016 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.017 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.017 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.017 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.018 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.018 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.019 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.019 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.019 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.019 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.020 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.020 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.021 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.021 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.021 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.022 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.022 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.022 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.023 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.023 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.024 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.024 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:947:xio_rdma_calc_pool_size() pool size: alloc_sz:26738688, num_tasks:3264, buf_sz:8192
14/01/26 13:45:15.024 TRACE LogFromNative (209) ../common/xio_conn.c:502:xio_conn_on_recv_setup_rsp() receiving setup respnse
14/01/26 13:45:15.040 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1169:xio_rdma_primary_pool_alloc() pool buf:0x7fa5d795f000, mr:0xc15a30 lkey:0xc0010e89
14/01/26 13:45:15.042 DEBUG LogFromNative (212) ../common/xio_session_client.c:822:xio_on_conn_event_client() session: [notification] - conn established. session:0xb10eb0, conn:0xb11030
14/01/26 13:45:15.043 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:236:xio_rdma_xmit() XMIT: tx_window:256, peer_credits:288, sqe_avail:256
14/01/26 13:45:15.043 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:1, len1:102, len2:0, send_flags:10
14/01/26 13:45:15.043 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.043 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.044 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.044 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.044 DEBUG LogFromNative (212) ../common/xio_session_client.c:474:xio_on_setup_rsp_recv() task recycled
14/01/26 13:45:15.044 TRACE LogFromNative (209) ../common/xio_session_client.c:527:xio_on_setup_rsp_recv() session state is now ACCEPT. session:0xb10eb0
14/01/26 13:45:15.045 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:236:xio_rdma_xmit() XMIT: tx_window:256, peer_credits:287, sqe_avail:256
14/01/26 13:45:15.045 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:1, len1:72, len2:0, send_flags:10
14/01/26 13:45:15.045 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1742:xio_rdma_open() xio_rdma_open: [new] handle:0xc15ce0
14/01/26 13:45:15.045 TRACE LogFromNative (209) ../common/xio_conn.c:1454:xio_conn_open() conn: [new] conn:0xc15bb0, transport_hndl:0xc15ce0
14/01/26 13:45:15.045 DEBUG LogFromNative (212) ../common/xio_session_client.c:178:xio_session_accept_connection() reconnecting to rdma://r-sw-fatty10-ib:60665
14/01/26 13:45:15.046 TRACE LogFromNative (209) ../common/xio_session_client.c:562:xio_on_setup_rsp_recv() sending fin request. session:0xb10eb0, connection:0xc15a90
14/01/26 13:45:15.046 TRACE LogFromNative (209) ../common/xio_conn.c:1596:xio_conn_close() conn: [putref] ptr:0xb11030, refcnt:1
14/01/26 13:45:15.046 DEBUG LogFromNative (212) ../common/xio_session_client.c:832:xio_on_conn_event_client() session: [notification] - conn closed. session:0xb10eb0, conn:0xb11030
14/01/26 13:45:15.046 DEBUG LogFromNative (212) ../common/xio_session.c:655:xio_on_conn_closed() session:0xb10eb0 - conn:0xb11030 close complete
14/01/26 13:45:15.046 TRACE LogFromNative (209) ../common/xio_session.c:686:xio_on_conn_closed() lead connection is closed
14/01/26 13:45:15.046 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.047 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.047 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.048 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.048 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.048 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.048 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ADDR_RESOLVED] rdma_hndl:0xc15ce0
14/01/26 13:45:15.049 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ADDR_RESOLVED, hndl:0xc15ce0
14/01/26 13:45:15.049 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.049 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.049 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ROUTE_RESOLVED] rdma_hndl:0xc15ce0
14/01/26 13:45:15.050 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ROUTE_RESOLVED, hndl:0xc15ce0
14/01/26 13:45:15.050 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:761:xio_setup_qp() rdma qp: [new] handle:0xc15ce0, qp:0x409d6, max inline:448
14/01/26 13:45:15.050 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.051 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.051 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.052 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.052 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.052 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.053 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.053 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.054 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1617:xio_connection_ev_handler() cm_event: [RDMA_CM_EVENT_ESTABLISHED] rdma_hndl:0xc15ce0
14/01/26 13:45:15.054 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:1542:xio_handle_cm_event() cm event RDMA_CM_EVENT_ESTABLISHED, hndl:0xc15ce0
14/01/26 13:45:15.054 DEBUG LogFromNative (212) ../common/xio_conn.c:1321:xio_on_transport_event() conn: [notification] - transport established. conn:0xc15bb0, transport:0xc15ce0
14/01/26 13:45:15.054 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1049:xio_rdma_initial_pool_run() post_recv conn_setup rx task:0xc1e000
14/01/26 13:45:15.054 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:1, len1:36, len2:0, send_flags:10
14/01/26 13:45:15.055 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.055 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.055 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.056 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.056 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.057 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.057 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.057 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.057 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.058 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.058 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.059 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.059 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.059 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.059 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.061 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.061 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.061 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.061 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.062 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.062 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.063 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.063 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.063 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.063 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.064 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.064 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.065 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.065 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.065 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.065 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.066 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.066 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.067 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.067 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.067 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.068 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.068 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.069 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.069 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.069 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.070 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.070 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.071 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.071 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.071 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.071 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.072 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.072 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.073 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.073 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.074 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.074 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.074 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.074 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.075 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.075 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.076 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.076 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.076 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.076 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.077 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.077 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.078 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.078 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.078 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.079 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.079 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.079 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.080 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.080 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.081 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.081 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.082 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.082 TRACE LogFromNative (209) ./rdma/xio_rdma_management.c:947:xio_rdma_calc_pool_size() pool size: alloc_sz:26738688, num_tasks:3264, buf_sz:8192
14/01/26 13:45:15.082 TRACE LogFromNative (209) ../common/xio_conn.c:502:xio_conn_on_recv_setup_rsp() receiving setup respnse
14/01/26 13:45:15.101 DEBUG LogFromNative (212) ./rdma/xio_rdma_management.c:1169:xio_rdma_primary_pool_alloc() pool buf:0x7fa5d5272000, mr:0xc04160 lkey:0xc0011089
14/01/26 13:45:15.103 DEBUG LogFromNative (212) ../common/xio_session_client.c:822:xio_on_conn_event_client() session: [notification] - conn established. session:0xb10eb0, conn:0xc15bb0
14/01/26 13:45:15.103 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:236:xio_rdma_xmit() XMIT: tx_window:256, peer_credits:288, sqe_avail:256
14/01/26 13:45:15.103 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:1, len1:72, len2:0, send_flags:10
14/01/26 13:45:15.103 TRACE LogFromNative (209) ../common/xio_session_client.c:748:xio_on_client_conn_established() session state is now ONLINE. session:0xb10eb0
14/01/26 13:45:15.103 DEBUG LogFromNative (212) CallbackFunctions.cc:120:on_session_established_callback() got on_session_established_callback
14/01/26 13:45:15.103 DEBUG LogFromNative (212) CallbackFunctions.cc:27:done_event_creating() inside a callback - stopping the event queue
14/01/26 13:45:15.103 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:117:break_event_loop() before break event loop (is_self_thread=1)
14/01/26 13:45:15.104 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:119:break_event_loop() after break event loop (is_self_thread=1)
14/01/26 13:45:15.104 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 1 events
14/01/26 13:45:15.105 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.105 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:236:xio_rdma_xmit() XMIT: tx_window:256, peer_credits:287, sqe_avail:256
14/01/26 13:45:15.105 TRACE LogFromNative (209) ./rdma/xio_rdma_datapath.c:142:xio_post_send() num_sge:2, len1:88, len2:133, send_flags:8
14/01/26 13:45:15.105 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.106 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.106 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.106 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.107 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 0 events
14/01/26 13:45:15.107 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:104:run_event_loop() before ev_loop_run. requested timeout is 0 msec
14/01/26 13:45:15.107 TRACE LogFromNative (209) CallbackFunctions.cc:63:on_msg_callback() on_msg_callback is 0x7fa5f4f0d4d0. num_iov = 1, len is 5 msg is 0x7fa5f4f0d520
14/01/26 13:45:15.107 DEBUG LogFromNative (212) CallbackFunctions.cc:27:done_event_creating() inside a callback - stopping the event queue
14/01/26 13:45:15.107 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:117:break_event_loop() before break event loop (is_self_thread=1)
14/01/26 13:45:15.108 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:119:break_event_loop() after break event loop (is_self_thread=1)
14/01/26 13:45:15.108 DEBUG LogFromNative (212) Context[0x7fa5f4f04360]:110:run_event_loop() after ev_loop_run. there are 1 events
