Call fails and after hangup message appears: "Trying to reconnect to the ring daemon" if TURN server is enabled
Issue generated from Tuleap's migration script. Originally submitted by: Ciro Santilli (cirosantilli)
Ubuntu 15.10, either:
- from source: https://github.com/cirosantilli/ring/tree/9d270d80b77a588fa87d6341a3813e0707353e81 with ./ubuntu-15.10-install.sh and ./ubuntu-15.10-run.sh
- latest Ubuntu package, dring 2.3.0-8ac6e93fa8-dirty gnome client 0.4.0 - 066e33b1
Enable TURN (accounts / select account / advanced)
Everything was working until before yesterday, so this is likely a problem with my install script or I have messed up my system in some way.
-
Check that neither client or daemon are running:
ps aux | grep ring
shows nothing. If anything,
kill -9
it. -
Run.
-
Try to call someone.
The critical daemon log line seems to be:
1455287612.879| 8840|ice\_transport.cpp:380 ] ICE start failed: No host candidate associated with srflx (PJNATH\_EICENOHOSTCAND)
Full daemon log:
Default Sink alsa\_output.pci-0000\_00\_1b.0.analog-stereo Default Source alsa\_input.pci-0000\_00\_1b.0.analog-stereo Default Sample Specification: s16le 2ch 44100Hz Default Channel Map: front-left,front-right 1455287583.461| 8840|videomanager.cpp:82 ] Setting default device to Integrated Camera 1455287584.393| 8873|ringaccount.cpp:1234 ] Generated DH params with 2048 bits in 1.082826s 1455287584.405| 8871|ringaccount.cpp:1234 ] Generated DH params with 2048 bits in 1.094249s 1455287584.928| 8840|ringaccount.cpp:782 ] Dht status : IPv4 connected; IPv6 connecting 1455287595.055| 8862|upnp\_context.cpp:539 ] UPnP: checking new device of type IGD: 'SAGEM EMTA42-1' 1455287595.088| 8862|upnp\_context.cpp:625 ] UPnP: got external IP: 85.170.244.103 1455287595.088| 8862|upnp\_context.cpp:646 ] UPnP: found a valid IGD: http://192.168.0.1:80 1455287595.088| 8862|upnp\_context.cpp:935 ] UPnP: removing all port mappings with description: "RING" and local ip: 192.168.0.18 1455287595.524| 8862|upnp\_context.cpp:955 ] UPnP: Failed to get GetGenericPortMappingEntry from: urn:schemas-upnp-org:service:WANIPConnection:1, 713: Unknown error code 1455287595.524| 8907|upnp\_context.cpp:289 ] UPnP: adding port mapping : 4350:4350, UDP 1455287595.650| 8840|ringaccount.cpp:782 ] Dht status : IPv4 connected; IPv6 connecting 1455287604.479| 8840|manager.cpp:436 ] New outgoing call to 2064feb6c99a71dd9cad606bd803702974964c7d 1455287604.479| 8840|ringaccount.cpp:181 ] Calling DHT peer 2064feb6c99a71dd9cad606bd803702974964c7d 1455287604.479| 8840|audiorecord.cpp:87 ] Generate filename for this call 20160212-153324 1455287604.479| 8840|recordable.cpp:33 ] Set recording options: 1455287604.479| 8840|ringbufferpool.cpp:114 ] Ringbuffer created with id '1099766449489202015' 1455287604.479| 8840|sipaccountbase.cpp:352 ] [Account 2704d896d0c9f9cc] Using public address 85.170.244.103 1455287604.479| 8840|ice\_transport.cpp:165 ] ICE: TURN='bootstrap.ring.cx', PORT=3478 1455287604.494| 8915|ice\_transport.cpp:63 ] Registered thread 0x7f9d4d0d00f0 (0x2288) 1455287604.634| 8915|ice\_transport.cpp:259 ] ICE initialization success 1455287604.634| 8915|ice\_transport.cpp:320 ] ICE as master 1455287604.634| 8915|ice\_transport.cpp:313 ] ICE [local] ufrag=404d3f1f, pwd=71dc9119 1455287604.634| 8915|ice\_transport.cpp:644 ] UPnP: Opening port(s) for ICE comp 1 and adding candidate with public IP 1455287604.634| 8915|upnp\_context.cpp:289 ] UPnP: adding port mapping : 57304:57304, UDP 1455287604.661| 8915|ice\_transport.cpp:627 ] succeed to add candidate for comp\_id=1 : 192.168.0.18 : 85.170.244.103 1455287604.661| 8915|upnp\_context.cpp:289 ] UPnP: adding port mapping : 51235:51235, UDP 1455287604.800| 8915|ice\_transport.cpp:627 ] succeed to add candidate for comp\_id=1 : 192.95.9.63 : 85.170.244.103 1455287604.801| 8840|manager.cpp:408 ] ----- Switch current call id to '1099766449489202015' ----- 1455287604.811| 8840|call.cpp:144 ] [call:1099766449489202015] state change 0/0, cnx 0/1, code 0 1455287604.821| 8840|ringaccount.cpp:809 ] Query for local certificate store: 2064feb6c99a71dd9cad606bd803702974964c7d: 1 found. 1455287612.809| 8840|ringaccount.cpp:238 ] Succesfully put ICE descriptor on DHT 1455287612.879| 8840|ringaccount.cpp:249 ] ICE request replied from DHT peer 2064feb6c99a71dd9cad606bd803702974964c7d 26c6be8 ec2dbd1 c0a80010 1 UDP 2130706431 192.168.0.16 34500 typ host c05f093f 1 UDP 16777215 192.95.9.63 62022 typ relay 1455287612.879| 8840|call.cpp:144 ] [call:1099766449489202015] state change 0/0, cnx 1/2, code 0 1455287612.879| 8840|call.cpp:163 ] [call:1099766449489202015] emit client call state change CONNECTING, code 0 1455287612.879| 8840|ice\_transport.cpp:373 ] ICE negotiation starting (2 remote candidates) 1455287612.879| 8840|ice\_transport.cpp:380 ] ICE start failed: No host candidate associated with srflx (PJNATH\_EICENOHOSTCAND) 1455287612.880| 8840|videomanager.cpp:82 ] Setting default device to Integrated Camera ring: ../src/pj/timer.c:501: schedule\_w\_grp\_lock: Assertion `entry->cb != ((void \*)0)' failed. 5:33:00.866 os\_core\_unix.c !pjlib 2.4.5 for POSIX initialized
-
Click hang up call. Sometimes UI shows:
Trying to reconnect to the ring daemon
and
ps aux | grep ring
shows:/usr/lib/x86\_64-linux-gnu/dring
as the only dring: looks like the other one died, and that gnome-ring then opened the one installed from the Ubuntu package?