google-code-export / red5

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

App disconnect after runnning approx. 12 hours #439

Closed GoogleCodeExporter closed 9 years ago

GoogleCodeExporter commented 9 years ago
Hi, I'm curently developping an application which produces a RTMP live stream. 
This stream is then send to red5. I check several times that the stream has no 
problem by checking it with the publisher app example. The problem resides in 
the fact that after approx. 12 hours running red5 send an exception and quit 
... here is the log : 

2013-09-20 02:42:57,928 [NioProcessor-2] WARN  o.r.s.net.rtmp.RTMPMinaIoHandler 
- Exception caught on session: 1
org.apache.mina.core.write.WriteTimeoutException: null
        at org.apache.mina.core.session.AbstractIoSession.notifyWriteTimeout(AbstractIoSession.java:1323) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.session.AbstractIoSession.notifyIdleSession(AbstractIoSession.java:1305) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.session.AbstractIoSession.notifyIdleness(AbstractIoSession.java:1282) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.notifyIdleSessions(AbstractPollingIoProcessor.java:743) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$900(AbstractPollingIoProcessor.java:67) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1124) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) ~[na:1.7.0_25]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ~[na:1.7.0_25]
        at java.lang.Thread.run(Thread.java:724) ~[na:1.7.0_25]
2013-09-20 02:42:57,987 [NioProcessor-2] WARN  o.r.s.net.rtmp.RTMPMinaIoHandler 
- Exception caught on session: 1
org.apache.mina.core.write.WriteToClosedSessionException: null
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.clearWriteRequestQueue(AbstractPollingIoProcessor.java:638) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.removeNow(AbstractPollingIoProcessor.java:590) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.removeSessions(AbstractPollingIoProcessor.java:560) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$800(AbstractPollingIoProcessor.java:67) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1121) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) ~[na:1.7.0_25]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ~[na:1.7.0_25]
        at java.lang.Thread.run(Thread.java:724) ~[na:1.7.0_25]
2013-09-20 02:42:57,988 [NioProcessor-2] INFO  o.r.s.net.rtmp.RTMPMinaIoHandler 
- Session closed: 1
2013-09-20 02:42:57,988 [NioProcessor-2] INFO  
o.r.s.stream.ClientBroadcastStream - Stream close
2013-09-20 02:42:57,988 [NioProcessor-2] INFO  
o.r.s.stream.ClientBroadcastStream - Provider disconnect
2013-09-20 02:42:57,989 [NioProcessor-2] INFO  
o.r.s.stream.ClientBroadcastStream - Provider disconnect
2013-09-20 02:42:57,989 [NioProcessor-2] INFO  
org.red5.demos.oflaDemo.Application - W3C x-category:stream x-event:unpublish 
c-ip:127.0.0.1 cs-bytes:2896503812 sc-bytes:3824254 
x-sname:32966076-4ef7-44b4-adad-ca685b8dd4d2 x-file-length:44284 
x-name:live_test
2013-09-20 02:42:57,991 [NioProcessor-2] INFO  
org.red5.demos.oflaDemo.Application - W3C x-category:session x-event:disconnect 
c-ip:127.0.0.1 c-client-id:0
2013-09-20 02:42:57,991 [NioProcessor-2] INFO  
org.red5.demos.oflaDemo.Application - oflaDemo appDisconnect
2013-09-20 02:42:57,991 [NioProcessor-2] INFO  o.r.s.net.rtmp.RTMPMinaIoHandler 
- Session closed: 1
2013-09-20 02:42:57,992 [NioProcessor-2] WARN  o.r.s.net.rtmp.RTMPMinaIoHandler 
- Exception caught on session: 1
java.lang.NullPointerException: null
        at org.red5.server.net.rtmp.RTMPMinaIoHandler.sessionClosed(RTMPMinaIoHandler.java:114) ~[red5-server.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.sessionClosed(DefaultIoFilterChain.java:663) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextSessionClosed(DefaultIoFilterChain.java:408) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$900(DefaultIoFilterChain.java:47) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.sessionClosed(DefaultIoFilterChain.java:772) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.filter.codec.ProtocolCodecFilter.sessionClosed(ProtocolCodecFilter.java:367) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextSessionClosed(DefaultIoFilterChain.java:408) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$900(DefaultIoFilterChain.java:47) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.sessionClosed(DefaultIoFilterChain.java:772) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.IoFilterAdapter.sessionClosed(IoFilterAdapter.java:88) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextSessionClosed(DefaultIoFilterChain.java:408) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$900(DefaultIoFilterChain.java:47) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.sessionClosed(DefaultIoFilterChain.java:772) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.IoFilterAdapter.sessionClosed(IoFilterAdapter.java:88) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextSessionClosed(DefaultIoFilterChain.java:408) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireSessionClosed(DefaultIoFilterChain.java:401) [mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.service.IoServiceListenerSupport.fireSessionDestroyed(IoServiceListenerSupport.java:244) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.removeNow(AbstractPollingIoProcessor.java:600) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.service.IoServiceListenerSupport.fireSessionDestroyed(IoServiceListenerSupport.java:244) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.removeNow(AbstractPollingIoProcessor.java:600) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.removeSessions(AbstractPollingIoProcessor.java:560) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$800(AbstractPollingIoProcessor.java:67) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1121) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) ~[mina-core-2.0.8-SNAPSHOT.jar:na]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) ~[na:1.7.0_25]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ~[na:1.7.0_25]
        at java.lang.Thread.run(Thread.java:724) ~[na:1.7.0_25]

i'm using red5 1.0.2 on a ubuntu 12.04 64bits VM.

Thanks, best regards !

Original issue reported on code.google.com by battin.b...@gmail.com on 20 Sep 2013 at 7:02

GoogleCodeExporter commented 9 years ago
The server timed out attempting to write to your client; why did that happen? 
No way to figure that out with what is shown here as it could be anything. Its 
much like someone talking to you and then you just walk away...

Original comment by mondain on 22 Sep 2013 at 11:36

GoogleCodeExporter commented 9 years ago

Original comment by mondain on 6 Oct 2013 at 12:37