While we are doing a conferencing app is crashing for everyone frequently, we debug the issue and found for some user Java.io.IOException: Connection reset by peer in server logs due to which websocket connection has been closed for everyone and app is crashing. Attached is the log snippet from server logs :
2020-05-31 03:26:10,219 [vert.x-worker-thread-19] INFO i.a.e.adaptive.StreamAdaptor - Flushing video encoder:SFUForwarder for stream adaptor:756710306 stream id:8527199113 2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] ERROR i.a.e.w.WebSocketEnterpriseHandler - Error: java.io.IOException: java.io.IOException: Connection reset by peer at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:315) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:258) at org.apache.tomcat.websocket.WsSession.sendCloseMessage(WsSession.java:612) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:497) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:459) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:176) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:54) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:53) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:806) at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1682) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.lang.Thread.run(Thread.java:748) Caused by: java.io.IOException: Connection reset by peer at sun.nio.ch.FileDispatcherImpl.read0(Native Method) at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39) at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223) at sun.nio.ch.IOUtil.read(IOUtil.java:197) at sun.nio.ch.UnixAsynchronousSocketChannelImpl.finishRead(UnixAsynchronousSocketChannelImpl.java:388) at sun.nio.ch.UnixAsynchronousSocketChannelImpl.finish(UnixAsynchronousSocketChannelImpl.java:191) at sun.nio.ch.UnixAsynchronousSocketChannelImpl.onEvent(UnixAsynchronousSocketChannelImpl.java:213) at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:293) ... 1 more
2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] INFO i.a.e.w.WebSocketEnterpriseHandler - streamId for processLeaveCommand:8527199113 2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] INFO i.a.e.w.WebSocketEnterpriseHandler - leaving room room1 because websocket connection closed 2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Stop is called for 8527199113 for 1370027384 2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCMuxer - unregister webrtc client(1370027384) to webrtc muxer(360p - codec:H264) for stream: 8527199113 current viewer count:0 decremented:true 2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Disposing audio source for stream Id 8527199113 2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Closing and disposing peer connection for stream Id 8527199113 for 1370027384 2020-05-31 03:26:10,223 [vert.x-worker-thread-19] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:aac for stream adaptor:756710306 stream id:8527199113 2020-05-31 03:26:10,223 [network_thread - 20664] INFO org.webrtc.Logging - Tag:WebRtcAudioTrackExternal - Message:GetPlayoutUnderrunCount 2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - IceConnectionState: CLOSED instance: 1370027384 2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - Stop is already called for 8527199113 2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - onSignalingChange : CLOSED 2020-05-31 03:26:10,224 [network_thread - 20664] INFO org.webrtc.Logging - Tag:WebRtcAudioRecordExternal - Message:stopRecording 2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:libopus for stream adaptor:756710306 stream id:8527199113 2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.enterprise.webrtc.WebRTCAdaptor - unregistering 8527199113 muxer with 360p and codec: H264 from webrtc adaptor 2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.enterprise.webrtc.WebRTCAdaptor - Decreasing number of live streams: 0 and stream id:8527199113
Please suggest what's the issue since our app is live and user are complaining lot about the issue
Question
Sachin Gupta
2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] ERROR i.a.e.w.WebSocketEnterpriseHandler - Error: java.io.IOException: java.io.IOException: Connection reset by peer
at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:315)
at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:258)
at org.apache.tomcat.websocket.WsSession.sendCloseMessage(WsSession.java:612)
at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:497)
at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:459)
at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:176)
at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:54)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:53)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:806)
at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1682)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.io.IOException: Connection reset by peer
at sun.nio.ch.FileDispatcherImpl.read0(Native Method)
at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39)
at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223)
at sun.nio.ch.IOUtil.read(IOUtil.java:197)
at sun.nio.ch.UnixAsynchronousSocketChannelImpl.finishRead(UnixAsynchronousSocketChannelImpl.java:388)
at sun.nio.ch.UnixAsynchronousSocketChannelImpl.finish(UnixAsynchronousSocketChannelImpl.java:191)
at sun.nio.ch.UnixAsynchronousSocketChannelImpl.onEvent(UnixAsynchronousSocketChannelImpl.java:213)
at sun.nio.ch.EPollPort$EventHandlerTask.run(EPollPort.java:293)
... 1 more
2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] INFO i.a.e.w.WebSocketEnterpriseHandler - streamId for processLeaveCommand:8527199113
2020-05-31 03:26:10,223 [http-nio2-0.0.0.0-5080-exec-4] INFO i.a.e.w.WebSocketEnterpriseHandler - leaving room room1 because websocket connection closed
2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Stop is called for 8527199113 for 1370027384
2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCMuxer - unregister webrtc client(1370027384) to webrtc muxer(360p - codec:H264) for stream: 8527199113 current viewer count:0 decremented:true
2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Disposing audio source for stream Id 8527199113
2020-05-31 03:26:10,223 [webrtc-client-stream-8527199113-hashcode-1370027384] INFO i.a.enterprise.webrtc.WebRTCClient - Closing and disposing peer connection for stream Id 8527199113 for 1370027384
2020-05-31 03:26:10,223 [vert.x-worker-thread-19] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:aac for stream adaptor:756710306 stream id:8527199113
2020-05-31 03:26:10,223 [network_thread - 20664] INFO org.webrtc.Logging - Tag:WebRtcAudioTrackExternal - Message:GetPlayoutUnderrunCount
2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - IceConnectionState: CLOSED instance: 1370027384
2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - Stop is already called for 8527199113
2020-05-31 03:26:10,224 [network_thread - 20664] INFO i.a.enterprise.webrtc.WebRTCClient - onSignalingChange : CLOSED
2020-05-31 03:26:10,224 [network_thread - 20664] INFO org.webrtc.Logging - Tag:WebRtcAudioRecordExternal - Message:stopRecording
2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:libopus for stream adaptor:756710306 stream id:8527199113
2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.enterprise.webrtc.WebRTCAdaptor - unregistering 8527199113 muxer with 360p and codec: H264 from webrtc adaptor
2020-05-31 03:26:10,225 [vert.x-worker-thread-19] INFO i.a.enterprise.webrtc.WebRTCAdaptor - Decreasing number of live streams: 0 and stream id:8527199113
Link to comment
Share on other sites
Top Posters For This Question
1
Popular Days
May 31
1
Top Posters For This Question
Sachin Gupta 1 post
Popular Days
May 31 2020
1 post
0 answers to this question
Recommended Posts