search

pgaval / red5phone

Automatically exported from code.google.com/p/red5phone
0 stars 0 forks source link

Subsequent sip registration failure. #104

Open GoogleCodeExporter opened 9 years ago

GoogleCodeExporter commented 9 years ago 

What version of the product are you using? On what operating system?

latest svn checkout on a centos 5.0 machine.

Original issue reported on code.google.com by mustafa...@gmail.com on 25 Mar 2010 at 5:01

GoogleCodeExporter commented 9 years ago 
[deleted comment]
GoogleCodeExporter commented 9 years ago 
Hi, 

just observed red5phone fails to register sometimes, to reproduce this problem 
try subsequent register attempts, it will fail to register sometime 
and according to logs it's because red5phone tries to bind itself to a local 
port which is already opened by another process or red5phone session, here are 
the logs.

SipProvider-5078: Date: 05:52:30.857 Thu 25 Mar 2010
SipProvider-5078: SipStack: mjsip stack 1.6
SipProvider-5078: new SipProvider(): 5078/udp/tcp
Exception: java.net.BindException: Address already in use
        at java.net.PlainDatagramSocketImpl.bind0(Native Method)
        at 
java.net.AbstractPlainDatagramSocketImpl.bind(AbstractPlainDatagramSocketImpl.ja
va:77
)
        at java.net.DatagramSocket.bind(DatagramSocket.java:369)
        at java.net.DatagramSocket.<init>(DatagramSocket.java:228)
        at java.net.DatagramSocket.<init>(DatagramSocket.java:281)
        at java.net.DatagramSocket.<init>(DatagramSocket.java:253)
        at org.zoolu.net.UdpSocket.<init>(UdpSocket.java:48)
        at org.zoolu.sip.provider.UdpTransport.<init>(UdpTransport.java:54)
        at 
org.zoolu.sip.provider.SipProvider.startTrasport(SipProvider.java:362)
        at org.zoolu.sip.provider.SipProvider.<init>(SipProvider.java:263)
        at org.red5.server.webapp.sip.SIPUser.login(SIPUser.java:190)
        at org.red5.server.webapp.sip.Application.login(Application.java:217)
        at org.red5.server.webapp.sip.Application.open(Application.java:192)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.jav
a:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        at 
org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:200)
        at 
org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:118)
        at 
org.red5.server.net.rtmp.RTMPHandler.invokeCall(RTMPHandler.java:165)
        at org.red5.server.net.rtmp.RTMPHandler.onInvoke(RTMPHandler.java:374)
        at 
org.red5.server.net.rtmp.BaseRTMPHandler.messageReceived(BaseRTMPHandler.java:13
8)
        at 
org.red5.server.net.rtmp.RTMPMinaIoHandler.messageReceived(RTMPMinaIoHandler.jav
a:180
)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived
(Defa
ultIoFilterChain.java:713)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.red5.server.net.filter.TrafficShapingFilter.messageReceived(TrafficShapingFi
lter.
java:204)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.flush
(Prot
ocolCodecFilter.java:375)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFi
lter.
java:229)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter
.java
:119)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(Defaul
tIoFi
lterChain.java:426)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoPr
ocess
or.java:638)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingI
oProc
essor.java:598)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingI
oProc
essor.java:587)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.access$400(AbstractPolli
ngIoP
rocessor.java:61)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPo
lling
IoProcessor.java:969)
        at 
org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:636)

Exception: java.net.BindException: Address already in use
        at java.net.PlainSocketImpl.socketBind(Native Method)
        at 
java.net.AbstractPlainSocketImpl.bind(AbstractPlainSocketImpl.java:336)
        at java.net.ServerSocket.bind(ServerSocket.java:336)
        at java.net.ServerSocket.<init>(ServerSocket.java:202)
        at java.net.ServerSocket.<init>(ServerSocket.java:114)
        at org.zoolu.net.TcpServer.init(TcpServer.java:90)
        at org.zoolu.net.TcpServer.<init>(TcpServer.java:66)
        at 
org.zoolu.sip.provider.SipProvider.startTrasport(SipProvider.java:373)
        at org.zoolu.sip.provider.SipProvider.<init>(SipProvider.java:263)
        at org.red5.server.webapp.sip.SIPUser.login(SIPUser.java:190)
        at org.red5.server.webapp.sip.Application.login(Application.java:217)
        at org.red5.server.webapp.sip.Application.open(Application.java:192)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.jav
a:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        at 
org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:200)
        at 
org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:118)
        at 
org.red5.server.net.rtmp.RTMPHandler.invokeCall(RTMPHandler.java:165)
        at org.red5.server.net.rtmp.RTMPHandler.onInvoke(RTMPHandler.java:374)
        at 
org.red5.server.net.rtmp.BaseRTMPHandler.messageReceived(BaseRTMPHandler.java:13
8)
        at 
org.red5.server.net.rtmp.RTMPMinaIoHandler.messageReceived(RTMPMinaIoHandler.jav
a:180
)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived
(Defa
ultIoFilterChain.java:713)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.red5.server.net.filter.TrafficShapingFilter.messageReceived(TrafficShapingFi
lter.
java:204)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.flush
(Prot
ocolCodecFilter.java:375)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFi
lter.
java:229)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilte
rChai
n.java:46)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceive
d(Def
aultIoFilterChain.java:793)
        at 
org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter
.java
:119)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(De
fault
IoFilterChain.java:434)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(Defaul
tIoFi
lterChain.java:426)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoPr
ocess
or.java:638)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingI
oProc
essor.java:598)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingI
oProc
essor.java:587)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor.access$400(AbstractPolli
ngIoP
rocessor.java:61)
        at 
org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPo
lling
IoProcessor.java:969)
        at 
org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:636)

ExtendedInviteDialog#927: changed dialog state: D_INIT
ExtendedInviteDialog#927: changed dialog state: D_WAITING
TransactionServer#6733: id: INVITE
TransactionServer#6733: created
TransactionServer#6733: start
TransactionServer#6733: changed transaction state: T_Waiting
SipProvider-5078: adding SipProviderListener: INVITE
SipProvider-5078: 1 listeners: INVITE, 
Exception: java.lang.NullPointerException
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:773)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:754)
        at local.net.KeepAliveSip.sendToken(KeepAliveSip.java:81)
        at local.net.KeepAliveUdp.run(KeepAliveUdp.java:156)
        at local.net.KeepAliveSip.run(KeepAliveSip.java:88)

TransactionClient#6734: id: 417749410747@127.0.0.1-1-REGISTER-127.0.0.1:5078-
z9hG4bK194866013
TransactionClient#6734: created
TransactionClient#6734: start
TransactionClient#6734: changed transaction state: T_Trying
SipProvider-5078: adding SipProviderListener: 417749410747@127.0.0.1-1-
REGISTER-127.0.0.1:5078-z9hG4bK194866013
SipProvider-5078: 2 listeners: INVITE, 417749410747@127.0.0.1-1-
REGISTER-127.0.0.1:5078-z9hG4bK194866013, 
SipProvider-5078: using transport udp
SipProvider-5078: Resolving host address 'rtsip.vopium.com'
SipProvider-5078: Sending message to udp:77.66.2.136:5060
Exception: java.lang.NullPointerException
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:773)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:754)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:921)
        at 
org.zoolu.sip.transaction.TransactionClient.request(TransactionClient.java:85)
        at 
org.red5.server.webapp.sip.SIPRegisterAgent.register(SIPRegisterAgent.java:189)
        at 
org.red5.server.webapp.sip.SIPRegisterAgent.register(SIPRegisterAgent.java:145)
        at 
org.red5.server.webapp.sip.SIPRegisterAgent.run(SIPRegisterAgent.java:257)
        at java.lang.Thread.run(Thread.java:636)

TransactionClient#6734: Retransmission timeout expired
SipProvider-5078: using transport udp
SipProvider-5078: Resolving host address 'rtsip.vopium.com'
SipProvider-5078: Sending message to udp:77.66.2.136:5060
Exception: java.lang.NullPointerException
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:773)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:754)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:921)
        at 
org.zoolu.sip.transaction.TransactionClient.onTimeout(TransactionClient.java:130
)
        at org.zoolu.tools.Timer.onInnerTimeout(Timer.java:126)
        at org.zoolu.tools.InnerTimer.run(InnerTimer.java:43)

TransactionClient#6734: Retransmission timeout expired
SipProvider-5078: using transport udp
SipProvider-5078: Resolving host address 'rtsip.vopium.com'
SipProvider-5078: Sending message to udp:77.66.2.136:5060
Exception: java.lang.NullPointerException
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:773)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:754)
        at 
org.zoolu.sip.provider.SipProvider.sendMessage(SipProvider.java:921)
        at 
org.zoolu.sip.transaction.TransactionClient.onTimeout(TransactionClient.java:130
)
        at org.zoolu.tools.Timer.onInnerTimeout(Timer.java:126)
        at org.zoolu.tools.InnerTimer.run(InnerTimer.java:43)

Original comment by mustafa...@gmail.com on 25 Mar 2010 at 5:03