[jitsi-users] Ice4j -Mobile 4G TURN - Failed to send BINDING-REQUEST(0x1)


#1

I have been testing how to use TURN servers, but this error appears whenever I try to run Ice with an Android's 4G network. Are there any suggestions on how I can fix this?

-Thanks for your time,
Max

Specific error:
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.StunCandidateHarvest sendRequest
INFO: Failed to send BINDING-REQUEST(0x1)[attrib.count=2 len=24 tranID=0x45197C7C4801F580F3739EBA] through /192.168.2.15:5001/udp to ipv6.sip-communicator.net:3478/udp
java.lang.IllegalArgumentException: unresolved address

Complete Error Log:
Start TCP Server
        Start TCP Thread
   New Client Connected
Server <<< Video||3udpl||6ts0umjbictlin5vk8uit2flvb||candidate:2 1 udp 2130706431 30.33.216.45 6001 typ host||candidate:1 1 udp 2130706431 fe80::aca4:43ff:fedf:9e95 6001 typ host||candidate:2 1 udp 2130706431 30.33.216.45 6001 typ host
        Start ICE Thread
Sep 15, 2014 8:23:00 PM org.ice4j.ice.Agent createMediaStream
INFO: Create media stream for data
Sep 15, 2014 8:23:00 PM org.ice4j.ice.Agent createComponent
INFO: Create component data.1
Sep 15, 2014 8:23:00 PM org.ice4j.ice.Agent gatherCandidates
INFO: Gather candidates for component data.1
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.HostCandidateHarvester harvest
INFO: End candidate harvest within 154 ms, for org.ice4j.ice.harvest.HostCandidateHarvester, component: 1
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.StunCandidateHarvest sendRequest
INFO: Failed to send BINDING-REQUEST(0x1)[attrib.count=2 len=24 tranID=0x45197C7C4801F580F3739EBA] through /192.168.2.15:5001/udp to ipv6.sip-communicator.net:3478/udp
java.lang.IllegalArgumentException: unresolved address
at java.net.DatagramPacket.setSocketAddress(DatagramPacket.java:313)
at java.net.DatagramPacket.<init>(DatagramPacket.java:140)
at org.ice4j.stack.Connector.sendMessage(Connector.java:267)
at org.ice4j.stack.NetAccessManager.sendMessage(NetAccessManager.java:380)
at org.ice4j.stack.StunClientTransaction.sendRequest0(StunClientTransaction.java:299)
at org.ice4j.stack.StunClientTransaction.sendRequest(StunClientTransaction.java:277)
at org.ice4j.stack.StunStack.sendRequest(StunStack.java:424)
at org.ice4j.ice.harvest.StunCandidateHarvest.sendRequest(StunCandidateHarvest.java:1206)
at org.ice4j.ice.harvest.StunCandidateHarvest.startResolvingCandidate(StunCandidateHarvest.java:1313)
at org.ice4j.ice.harvest.StunCandidateHarvester.startResolvingCandidate(StunCandidateHarvester.java:321)
at org.ice4j.ice.harvest.StunCandidateHarvester.harvest(StunCandidateHarvester.java:237)
at org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement.harvest(CandidateHarvesterSet.java:410)
at org.ice4j.ice.harvest.CandidateHarvesterSet$1CandidateHarvesterSetTask.run(CandidateHarvesterSet.java:160)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)

Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.StunCandidateHarvester startResolvingCandidate
INFO: Failed to start resolving host candidate candidate:null 1 udp 0 192.168.2.15 5001 typ host
org.ice4j.StunException: unresolved address
at org.ice4j.ice.harvest.StunCandidateHarvest.sendRequest(StunCandidateHarvest.java:1227)
at org.ice4j.ice.harvest.StunCandidateHarvest.startResolvingCandidate(StunCandidateHarvest.java:1313)
at org.ice4j.ice.harvest.StunCandidateHarvester.startResolvingCandidate(StunCandidateHarvester.java:321)
at org.ice4j.ice.harvest.StunCandidateHarvester.harvest(StunCandidateHarvester.java:237)
at org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement.harvest(CandidateHarvesterSet.java:410)
at org.ice4j.ice.harvest.CandidateHarvesterSet$1CandidateHarvesterSetTask.run(CandidateHarvesterSet.java:160)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.IllegalArgumentException: unresolved address
at java.net.DatagramPacket.setSocketAddress(DatagramPacket.java:313)
at java.net.DatagramPacket.<init>(DatagramPacket.java:140)
at org.ice4j.stack.Connector.sendMessage(Connector.java:267)
at org.ice4j.stack.NetAccessManager.sendMessage(NetAccessManager.java:380)
at org.ice4j.stack.StunClientTransaction.sendRequest0(StunClientTransaction.java:299)
at org.ice4j.stack.StunClientTransaction.sendRequest(StunClientTransaction.java:277)
at org.ice4j.stack.StunStack.sendRequest(StunStack.java:424)
at org.ice4j.ice.harvest.StunCandidateHarvest.sendRequest(StunCandidateHarvest.java:1206)
... 10 more

Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.StunCandidateHarvester startResolvingCandidate
WARNING: harvest did not start, removed: org.ice4j.ice.harvest.StunCandidateHarvest@fb4538d
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: STUN harvester for srvr: ipv6.sip-communicator.net:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 24 ms, for org.ice4j.ice.harvest.StunCandidateHarvester, component: 1
Sep 15, 2014 8:23:00 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: STUN harvester for srvr: ipv6.sip-communicator.net:3478/udp
Sep 15, 2014 8:23:01 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: STUN harvester for srvr: sip-communicator.net/130.79.90.150:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:01 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 1122 ms, for org.ice4j.ice.harvest.StunCandidateHarvester, component: 1
Sep 15, 2014 8:23:01 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: STUN harvester for srvr: sip-communicator.net/130.79.90.150:3478/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: TURN harvester for srvr: /2001:660:4701:1001:230:5ff:fe1a:805f:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 2222 ms, for org.ice4j.ice.harvest.TurnCandidateHarvester, component: 1
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: TURN harvester for srvr: jitsi.org/46.105.44.115:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 2224 ms, for org.ice4j.ice.harvest.TurnCandidateHarvester, component: 1
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: TURN harvester for srvr: /130.79.90.150:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 2225 ms, for org.ice4j.ice.harvest.TurnCandidateHarvester, component: 1
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.StunCandidateHarvester harvest
INFO: harvest / stream.component: TURN harvester for srvr: stun.xten.net/92.242.140.2:3478/udp / data / 1found 0 candidates.
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement harvest
INFO: End candidate harvest within 2227 ms, for org.ice4j.ice.harvest.TurnCandidateHarvester, component: 1
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: TURN harvester for srvr: /130.79.90.150:3478/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: TURN harvester for srvr: jitsi.org/46.105.44.115:3478/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: TURN harvester for srvr: /2001:660:4701:1001:230:5ff:fe1a:805f:3478/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.harvest.CandidateHarvesterSet$CandidateHarvesterSetElement setEnabled
INFO: disabling harvester: TURN harvester for srvr: stun.xten.net/92.242.140.2:3478/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent gatherCandidates
INFO: End candidate harvest for all harvesters within 2388 ms, component: 1
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /fdbc:7760:17d3:0:c8ce:5a17:c339:cc40:5001/udp (host)
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /fdbc:7760:17d3:0:ad04:129f:9571:7d48:5001/udp (host)
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /2001:0:9d38:6abd:5c:2e05:51bc:217a:5001/udp (host)
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /fe80:0:0:0:c8ce:5a17:c339:cc40%4:5001/udp (host)
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /fe80:0:0:0:5c:2e05:51bc:217a%8:5001/udp (host)
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent createComponent
INFO: /192.168.2.15:5001/udp (host)
Server >>> Video||a1j3g||1oslb6dp5i8l5qusbqkkc80l1s||candidate:1 1 udp 2113932031 192.168.2.15 5001 typ host||candidate:2 1 udp 2113939711 fdbc:7760:17d3:0:c8ce:5a17:c339:cc40 5001 typ host||candidate:3 1 udp 2113939711 fdbc:7760:17d3:0:ad04:129f:9571:7d48 5001 typ host||candidate:5 1 udp 2113939711 2001:0:9d38:6abd:5c:2e05:51bc:217a 5001 typ host||candidate:4 1 udp 2113937151 fe80:0:0:0:c8ce:5a17:c339:cc40 5001 typ host||candidate:6 1 udp 2113937151 fe80:0:0:0:5c:2e05:51bc:217a 5001 typ host||candidate:1 1 udp 2113932031 192.168.2.15 5001 typ host
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Component addRemoteCandidate
INFO: Add remote candidate for data.1: /30.33.216.45:6001/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Component addRemoteCandidate
INFO: Add remote candidate for data.1: /fe80:0:0:0:aca4:43ff:fedf:9e95:6001/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Component addRemoteCandidate
INFO: Add remote candidate for data.1: /30.33.216.45:6001/udp
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent startConnectivityEstablishment
INFO: Start ICE connectivity establishment
Sep 15, 2014 8:23:03 PM org.ice4j.ice.Agent initCheckLists
INFO: Init checklist for stream data
Sep 15, 2014 8:23:03 PM org.ice4j.ice.ConnectivityCheckClient startChecks
INFO: Start connectivity checks!
ICEServer <><><> Completed
Sep 15, 2014 8:23:04 PM org.ice4j.ice.ConnectivityCheckClient processTimeout
INFO: timeout for pair: /fe80:0:0:0:c8ce:5a17:c339:cc40%4:5001/udp -> /fe80:0:0:0:aca4:43ff:fedf:9e95:6001/udp (data.1), failing.
Sep 15, 2014 8:23:04 PM org.ice4j.ice.ConnectivityCheckClient processTimeout
INFO: timeout for pair: /fe80:0:0:0:5c:2e05:51bc:217a%8:5001/udp -> /fe80:0:0:0:aca4:43ff:fedf:9e95:6001/udp (data.1), failing.
Sep 15, 2014 8:23:04 PM org.ice4j.ice.ConnectivityCheckClient processTimeout
INFO: timeout for pair: /192.168.2.15:5001/udp -> /30.33.216.45:6001/udp (data.1), failing.
Sep 15, 2014 8:23:04 PM org.ice4j.ice.ConnectivityCheckClient processTimeout
INFO: timeout for pair: /192.168.2.15:5001/udp -> /30.33.216.45:6001/udp (data.1), failing.
Sep 15, 2014 8:23:04 PM org.ice4j.ice.ConnectivityCheckClient updateCheckListAndTimerStates
INFO: CheckList will failed in a few seconds if nosucceeded checks come
Sep 15, 2014 8:23:09 PM org.ice4j.ice.ConnectivityCheckClient$1 run
INFO: CheckList for stream data FAILED
Sep 15, 2014 8:23:09 PM org.ice4j.ice.Agent checkListStatesUpdated
INFO: ICE state is FAILED