AgoraIO / Signaling

18 stars 28 forks source link

Delayed messages or skip messages #7

Open umairgillani94 opened 5 years ago

umairgillani94 commented 5 years ago

I get messages after delay or some time the messages are skipped and not received on both iOS and android.

plutoless commented 5 years ago

which platform? Can we have your signaling logs pls?

umairgillani94 commented 5 years ago

Platform is IOS and Android both,

I checked in console and I was online in my signalKit

plutoless commented 5 years ago

@umairgillani94 yes if you could provide an issue log we can check with backend for potential issues.

umairgillani94 commented 5 years ago

I am attaching two images of the messages during the call. Please note that the first user "zeeshan" with the uid = "4218403" sent a message and it was received on another user "umair" with the uid = "4816549". After that uid = "4816549" sent three messages and those were not received to uid = "4218403". Please note that the app id is: 36931475376e48d69631c9162ee5455f Channel id is: B3009D51-86DD-452D-B23D-FA1882FAFCA7 And following are the logs below: message : Optional("1558090574664 : tcp.1 send : [1 22] line_ping:2") message : Optional("1558090574970 : tcp.1.1 recv : [11, 0] line_pong:2") message : Optional("1558090604151 : tcp.1 send : [1 22] line_ping:3") message : Optional("1558090613421 : tcp.1.1 closed") message : Optional("1558090613421 : usr user_send_channel_msg channelID="B3009D51-86DD-452D-B23D-FA1882FAFCA7" msg="{\n "type" : "3",\n "username" : "Zeeshan",\n "color" : "#77a6d0",\n "dateSent" : 1558090613419,\n "" msgID="" type=0") message : Optional("1558090613422 : call_api 0 5 channel_sendmsg 0") message : Optional("1558090613520 : call_api 0 6 user_getmsg 0") message : Optional("1558090613521 : usr.cb onReconnecting 1") message : Optional("1558090613521 : [ net ] resolve_hostname : "ulbs.sig.agora.io" ") message : Optional("1558090613522 : [ net ] uv_on_getaddrinfo_done2 status: ulbs.sig.agora.io 0") message : Optional("1558090613522 : dns. dns_result lbs-sig.agora.io:52.221.229.66") message : Optional("1558090613523 : [ net ] uv_udp_init") message : Optional("1558090613523 : ulbs bind 0.0.0.0") message : Optional("1558090613523 : ulbs send req 52.221.229.66 1 : 36931475376e48d69631c9162ee5455f") message : Optional("1558090613636 : ulbs data recv ok {"web2": [], "web": [["47.90.2.175", 8001], ["47.91.139.223", 8001], ["47.91.136.74", 8001], ["47.90.104.190", 8001], ["47.90.105.137", 8001]], "http": [["47.90.89.116", 80], ["47.90.91.211", 80], ["47.90.105.137", 80], ["47.90.87.207", 80], ["47.91.136.74", 80]], "tcp": [["47.90.105.82", 8181], ["47.90.81.78", 8184], ["47.90.89.116", 8187], ["47.90.91.211", 8186], ["47.90.104.190", 8184], ["47.90.4.18", 8182], ["47.90.89.116", 8184], ["47.90.91.211", 8183], ["") message : Optional("1558090613636 : ulbs result {"web2": [], "web": [["47.90.2.175", 8001], ["47.91.139.223", 8001], ["47.91.136.74", 8001], ["47.90.104.190", 8001], ["47.90.10") message : Optional("1558090613637 : tcp.2.0 connecting 47.90.81.78:8184") message : Optional("1558090613637 : [ net ] connect to 47.90.81.78") message : Optional("1558090613637 : tcp.2.1 connecting 47.91.136.74:8183") message : Optional("1558090613638 : [ net ] connect to 47.91.136.74") message : Optional("1558090613777 : tcp.2.1 connected 47.91.136.74:8183 0") message : Optional("1558090613778 : tcp.2 send : [0 55] line_login2 ua_jx2_5:9022227967:2649733821181534515 2 2") message : Optional("1558090613937 : tcp.2.0 connected 47.90.81.78:8184 0") message : Optional("1558090613937 : tcp.2.0 close on connected : work end 2 ") message : Optional("1558090613952 : tcp.2.1 recv : [19, 0] line_login_res ok 2") message : Optional("1558090613953 : tcp.2 send : [1 22] line_ping:1") message : Optional("1558090613954 : tcp.2 send : [1 127] channel_sub {"cid":"cs_fs2_4:2366210574","cname":"B3009D51-86DD-452D-B23D-FA1882FAFCA7","msgid":2,"v") message : Optional("1558090613955 : tcp_call 5 channel_sendmsg {"line":"ua_jx2_5:9022227967:2649733821181534515","msg":"{ n \"type\" : \"3\", n \"username\" : \"") message : Optional("1558090613960 : tcp.2 send : [1 333] call channel_sendmsg 5 0 {"line":"ua_jx2_5:9022227967:2649733821181534515","msg":"{ n \"type\" : \"") message : Optional("1558090613961 : tcp_call 6 user_getmsg {"line":"ua_jx2_5:9022227967:2649733821181534515","max":30,"ver_clear":1} ") message : Optional("1558090613961 : tcp.2 send : [1 94] call user_getmsg 6 0 {"line":"ua_jx2_5:9022227967:2649733821181534515","max":30,"ver_clear":1} ") message : Optional("1558090613961 : usr.cb onReconnected 77") message : Optional("1558090614134 : tcp.2.1 recv : [11, 0] line_pong:1") message : Optional("1558090614317 : tcp.2.1 recv : [69, 0] call_ret user_getmsg 6 0 {"ver_clear": 1, "result": "ok", "msgs": []} ") message : Optional("1558090614318 : call_ret 6 0 {"msgs":[],"result":"ok","ver_clear":1} ") message : Optional("1558090614344 : call_api 0 7 user_getmsg 0") message : Optional("1558090614344 : tcp_call 7 user_getmsg {"line":"ua_jx2_5:9022227967:2649733821181534515","max":30,"ver_clear":1} ") message : Optional("1558090614345 : tcp.2 send : [1 94] call user_getmsg 7 0 {"line":"ua_jx2_5:9022227967:2649733821181534515","max":30,"ver_clear":1} ") message : Optional("1558090614373 : tcp.2.1 recv : [45, 0] call_ret channel_sendmsg 5 0 {"result": "ok"} ") message : Optional("1558090614374 : call_ret 5 0 {"result":"ok"} ") message : Optional("1558090614374 : usr.cb onMessageSendSuccess ") message : Optional("1558090614550 : tcp.2.1 recv : [69, 0] call_ret user_getmsg 7 0 {"ver_clear": 1, "result": "ok", "msgs": []} ") message : Optional("1558090614551 : call_ret 7 0 {"msgs":[],"result":"ok","ver_clear":1} ") the LogKeys are - 17 May, 2019 the date to string - 17 May, 2019 message : Optional("1558090624352 : tcp.2 send : [1 22] line_ping:2") message : Optional("1558090624536 : tcp.2.1 recv : [11, 0] line_pong:2") message : Optional("1558090634910 : tcp.2 send : [1 22] line_ping:3") message : Optional("1558090635107 : tcp.2.1 recv : [11, 0] line_pong:3") message : Optional("1558090645485 : tcp.2 send : [1 22] line_ping:4") message : Optional("1558090645690 : tcp.2.1 recv : [11, 0] line_pong:4") message : Optional("1558090656052 : tcp.2 send : [1 22] line_ping:5") message : Optional("1558090656247 : tcp.2.1 recv : [11, 0] line_pong:5") message : Optional("1558090666613 : tcp.2 send : [1 22] line_ping:6") message : Optional("1558090666798 : tcp.2.1 recv : [11, 0] line_pong:6") message : Optional("1558090673540 : send rp 1 139.196.188.164") message : Optional("1558090677176 : tcp.2 send : [1 22] line_ping:7") message : Optional("1558090677382 : tcp.2.1 recv : [11, 0] line_pong:7") message : Optional("1558090687739 : tcp.2 send : [1 22] line_ping:8") message : Optional("1558090687955 : tcp.2.1 recv : [11, 0] line_pong:8") message : Optional("1558090698309 : tcp.2 send : [1 22] line_ping:9") message : Optional("1558090698503 : tcp.2.1 recv : [11, 0] line_pong:9") message : Optional("1558090708864 : tcp.2 send : [1 23] line_ping:10") message : Optional("1558090709053 : tcp.2.1 recv : [12, 0] line_pong:10") message : Optional("1558090711694 : tcp.2.1 recv : [16, 0] notify outofsync") message : Optional("1558090711695 : usr.cb onLogout 102") message : Optional("1558090711698 : tcp.2.1 closed") message : Optional("1558090760691 : usr user_send_channel_msg channelID="B3009D51-86DD-452D-B23D-FA1882FAFCA7" msg="{\n "body" : "Hsjan",\n "color" : "#77a6d0",\n "type" : "3",\n "dateSent" : 1558090760690,\n "imageU" msgID="" type=0") message : Optional("1558090760691 : usr.cb onMessageSendError 400") Message send failed with error: 400 message : Optional("1558090760691 : usr.cb onError send_channel_msg 1003 not login") message : Optional("1558090820870 : send rp 2 139.196.188.164") message : Optional("1558090872834 : usr user_send_channel_msg channelID="B3009D51-86DD-452D-B23D-FA1882FAFCA7" msg="{\n "imageUrl" : "https:\/\/firebasestorage.googleapis.com\/v0\/b\/sesh4-40ad0.appspot.com\/o\/image" msgID="" type=0") message : Optional("1558090872835 : usr.cb onMessageSendError 400") Message send failed with error: 400 message : Optional("1558090872835 : usr.cb onError send_channel_msg 1003 not login") message : Optional("1558090872836 : usr user_logout") message : Optional("1558090872837 : usr.cb onError logout 108 logout when logouted, ignore this action") Waiting for your kind response IMG_2883

IMG_1965

plutoless commented 5 years ago

@umairgillani94 the logs show that you have logged out after sending one message. That's why the 3 following messages were not successfully sent.

umairgillani94 commented 5 years ago

yes, that's exactly the issue is, but I have not called the logout function. Why it logged me out automatically?

plutoless commented 5 years ago

@umairgillani94 it usually means sth is wrong with your connection. but anyway you should be able to try to recover your connection by listening onLogout event to re-login signaling

umairgillani94 commented 5 years ago

oka I will try that and will be back to you if the issue still exists. Thanks.