IOS sdk not sending BYE

maria-farooq commented 7 years ago

this morning I had a call with @lefty on staging i used ios-sdk, my client name was carol call started around 08:39:34 UTC and lasted more than an hour. i properly clicked on hangup button. here are LoadBalancer logs and RC logs. https://app.box.com/files/0/f/17307973893/ios_sdk_not_sending_bye we can see INVITE from both lefty1 and carol and we only see BYE from lefty1 and not carol

atsakiridis commented 7 years ago

@maria-farooq from the ios logs it seems that a little before you hangup, the periodic registration with Restcomm fails with a Restcomm 503 Service Unavailable:

73:22 4/restcomm-olympus: NOTICE (ssc_sip.mm:2022) REGISTER: 503 Service Unavailable
73:22 4/restcomm-olympus: ERROR (ssc_sip.mm:2031) REGISTER failed: 503 Service Unavailable
73:22 4/restcomm-olympus: NOTICE (RCDevice.m:436) [RCDevice didSignallingError: {
  "NSLocalizedDescription" : "Error connecting to Restcomm: service unavailable"

And after that all signaling towards Restcomm fails, like the attempt to send a BYE:

84:04 4/restcomm-olympus: DEBUG (ssc_sip.mm:1371) UA: BYE to sips:16502460163@telestax.restcomm.com

Any idea why Restcomm/LB might have returned that?

atsakiridis commented 7 years ago

@maria-farooq I also checked again your second problematic session, which occurred in our daily meeting yesterday and it appears that ios olympus sends BYE out to Restcomm:

18:34 4/restcomm-olympus: DEBUG (common.m:45) send 956 bytes to tls/[50.17.127.170]:5061 at 14:17:26.155665:
   ------------------------------------------------------------------------

18:34 4/restcomm-olympus: DEBUG (common.m:45)    BYE sip:50.17.127.170:5060;transport=tcp SIP/2.0
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Via: SIP/2.0/TLS 192.168.8.100:65473;branch=z9hG4bKc3H9vZNcvZXDc
18:34 4/restcomm-olympus: DEBUG (common.m:45)    From: <sips:carol@telestax.restcomm.com>;tag=5UDZyjQ1cSH1e
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Call-ID: f4221f70-5c16-1235-4a8b-c96830d34c68
18:34 4/restcomm-olympus: DEBUG (common.m:45)    To: <sips:16502460163@telestax.restcomm.com>;tag=00608024_e25fc77d_57a5b08a_ea943d37
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Route: <sip:50.17.127.170:5061;transport=tls;lr;node_host=10.0.0.13;node_port=5081;version=0>
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Route: <sip:10.0.0.29:5080;transport=tcp;lr;node_host=10.0.0.13;node_port=5081;version=0>
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Max-Forwards: 70
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Content-Length: 0
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Supported: timer, 100rel
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Proxy-Authorization: Digest username="carol", realm="telestax.restcomm.com", nonce="37386430323338382d653862392d343", algorithm=MD5, uri="sip:50.17.127.170:5060;transport=tcp", response="b97925e1ab9ba90bd0542964729bb705"
18:34 4/restcomm-olympus: DEBUG (common.m:45)    CSeq: 102253912 BYE
18:34 4/restcomm-olympus: DEBUG (common.m:45)    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE
18:34 4/restcomm-olympus: DEBUG (common.m:45)    User-Agent: TelScale Restcomm iOS Client 1.0.0-beta.4.1+126
18:34 4/restcomm-olympus: DEBUG (common.m:45)

But didn't see a response coming in afterwards. Could you check the server side logs at 14:17:27 UTC, to see if there's anything wrong there?

maria-farooq commented 7 years ago

thanks @atsakiridis i will check and revert

maria-farooq commented 7 years ago

@atsakiridis i uploaded LB server logs in same box. I could not find BYE from carol any time around 14:17:27 UTC. in these logs you might find another call from carol around 13:33 UTC please ignore that as that was before the daily conference started. thanks Maria

RestComm / restcomm-ios-sdk

IOS sdk not sending BYE #545