search

ant-media / conference-call-application

Conference Call Application over Ant Media Server
18 stars 13 forks source link

Zombi Stream Error - (Resolve and Action: Warn User if it's not running the enterprise edition) #323

Open Evert-jvv opened 1 month ago

Evert-jvv commented 1 month ago

Short description

When I create the meeting using the conference application it looks like it is trying to join the meeting, but then it gets stuck on "Reconnecting..." with the following error message that pops up: Connection lost. Trying reconnect...

Environment

Steps to reproduce

  1. Install Ant Media (2.10) as well as the Conference Call Application (2.10)
  2. Go to the conference app URL (custom.domain.com:5443/appName) and try to create a meeting
  3. Once you have entered your name click "I'm ready to join"

Expected behavior

When you go on "I'm ready to join" it is expected that you should join the meeting room.

Actual behavior

When you go on "I'm ready to join", it says "joining the room..." and then after a few seconds it gets overlayed with a message that says "Reconnecting..." as well as a message in the top that says "Connection lost. Trying reconnect...""

Logs:

2024-08-04 20:49:10,760 [https-jsse-nio2-0.0.0.0-5443-exec-10] INFO  i.a.e.s.WebSocketApplicationHandler - Web Socket opened session:21 user-agent:[Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36]
2024-08-04 20:49:12,162 [https-jsse-nio2-0.0.0.0-5443-exec-5] INFO  io.antmedia.rest.RestServiceBase - Version Name 2.10.0 Version Type Community Edition
2024-08-04 20:49:18,520 [https-jsse-nio2-0.0.0.0-5443-exec-6] INFO  i.a.e.s.WebSocketLocalHandler - Web Socket opened session:22 user-agent:[Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36]
2024-08-04 20:49:33,239 [https-jsse-nio2-0.0.0.0-5443-exec-2] INFO  i.a.w.WebSocketCommunityHandler - received sdp type is offer NewUser_QffUUA7emG
2024-08-04 20:49:33,241 [network_thread - 7547] WARN  io.antmedia.webrtc.adaptor.Adaptor - onAddStream for stream: NewUser_QffUUA7emG
2024-08-04 20:49:33,242 [network_thread - 7547] WARN  io.antmedia.webrtc.adaptor.Adaptor - onCreate Success for stream: NewUser_QffUUA7emG
2024-08-04 20:49:33,244 [network_thread - 7547] INFO  io.antmedia.webrtc.adaptor.Adaptor - set localdescription on set success  for NewUser_QffUUA7emG
2024-08-04 20:49:33,245 [network_thread - 7547] WARN  io.antmedia.webrtc.adaptor.Adaptor - onIceCandidate
2024-08-04 20:49:33,245 [pool-298-thread-1] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Set startTime to 1722804573245 in Audio Track executor:NewUser_QffUUA7emG
2024-08-04 20:49:33,265 [network_thread - 7547] WARN  io.antmedia.webrtc.adaptor.Adaptor - onIceCandidate
2024-08-04 20:49:33,442 [NioProcessor-12] WARN  o.r.s.net.rtmp.InboundHandshake - Client not compatible
2024-08-04 20:49:33,483 [RTMPConnectionExecutor-4] INFO  i.a.AntMediaApplicationAdapter - W3C x-category:session x-event:connect c-ip:127.0.0.1 c-client-id:90
2024-08-04 20:49:33,568 [RTMPConnectionExecutor-4] INFO  i.a.s.AcceptOnlyStreamsWithWebhook - AcceptOnlyStreamsWithWebhook is not activated for stream NewUser_QffUUA7emG
2024-08-04 20:49:33,568 [RTMPConnectionExecutor-4] INFO  i.a.s.AcceptOnlyStreamsInDataStore - AcceptOnlyStreamsInDataStore is not activated. Accepting stream NewUser_QffUUA7emG
2024-08-04 20:49:33,569 [RTMPConnectionExecutor-4] INFO  org.red5.server.scope.BasicScope - ClientBroadcastStream already exists: org.red5.server.stream.ClientBroadcastStream@228cfd94 new: org.red5.server.stream.ClientBroadcastStream@228cfd94
2024-08-04 20:49:33,569 [RTMPConnectionExecutor-4] INFO  o.r.s.stream.ClientBroadcastStream - Stream start: NewUser_QffUUA7emG
2024-08-04 20:49:33,569 [RTMPConnectionExecutor-4] INFO  i.a.AntMediaApplicationAdapter - W3C x-category:stream x-event:publish c-ip:127.0.0.1 x-sname:9137d119-05b9-4477-80ea-7891fbd17451 x-name:NewUser_QffUUA7emG
2024-08-04 20:49:33,570 [pool-296-thread-1] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Initialize recorder takes 135ms for stream: NewUser_QffUUA7emG
2024-08-04 20:49:33,570 [RTMPConnectionExecutor-4] ERROR io.antmedia.muxer.MuxAdaptor - io.antmedia.enterprise.adaptive.EncoderAdaptor
2024-08-04 20:49:33,570 [RTMPConnectionExecutor-4] INFO  i.a.AntMediaApplicationAdapter - Saving zombi broadast to data store with streamId:NewUser_QffUUA7emG
2024-08-04 20:49:33,571 [RTMPConnectionExecutor-4] INFO  io.antmedia.muxer.MuxAdaptor - serverSettings exist io.antmedia.settings.ServerSettings@758a5cea
2024-08-04 20:49:33,571 [RTMPConnectionExecutor-4] INFO  io.antmedia.muxer.MuxAdaptor - vertx exist io.vertx.core.impl.VertxImpl@32d89eac
2024-08-04 20:49:33,571 [RTMPConnectionExecutor-4] INFO  io.antmedia.muxer.MuxAdaptor - Number of items in the queue while adaptor is being started to prepare is 0
2024-08-04 20:49:33,571 [vert.x-worker-thread-6] INFO  io.antmedia.muxer.MuxAdaptor - before prepare for NewUser_QffUUA7emG
2024-08-04 20:49:33,571 [vert.x-worker-thread-6] INFO  io.antmedia.muxer.MuxAdaptor - Number of items in the queue while starting: 0 for stream: NewUser_QffUUA7emG
2024-08-04 20:49:33,611 [RTMPConnectionExecutor-1] INFO  o.red5.server.stream.AbstractStream - metadata read data type -->>>> core map
2024-08-04 20:49:33,611 [RTMPConnectionExecutor-1] INFO  io.antmedia.muxer.MuxAdaptor - first received frame timestamp: 0 for stream:NewUser_QffUUA7emG 
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  i.a.muxer.parser.AACConfigParser - AAC object type:AAC_LC 
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  i.a.muxer.parser.AACConfigParser - AAC Sample rate:44100 
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  io.antmedia.muxer.MuxAdaptor - Video and audio is enabled in stream:NewUser_QffUUA7emG queue size: 15
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  io.antmedia.muxer.MuxAdaptor - Incoming video width: 640 height:360 stream:NewUser_QffUUA7emG
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  i.a.AntMediaApplicationAdapter - start publish leaved for stream:NewUser_QffUUA7emG
2024-08-04 20:49:33,612 [vert.x-worker-thread-14] INFO  io.antmedia.muxer.MuxAdaptor - Stream queue size:14 speed:0.0 for streamId:NewUser_QffUUA7emG 
2024-08-04 20:49:33,613 [vert.x-worker-thread-12] INFO  i.a.AntMediaApplicationAdapter -  Status of stream NewUser_QffUUA7emG is set to broadcasting with result: true
2024-08-04 20:49:35,613 [vert.x-eventloop-thread-50] INFO  i.a.AntMediaApplicationAdapter - Broadcast absolute time is not available for stream:NewUser_QffUUA7emG
2024-08-04 20:49:36,219 [https-jsse-nio2-0.0.0.0-5443-exec-2] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Video queue size: 0 video frame last timestamp: 2962
2024-08-04 20:49:36,219 [https-jsse-nio2-0.0.0.0-5443-exec-2] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Audio queue size: 0 audio frame count: 298
2024-08-04 20:49:36,219 [https-jsse-nio2-0.0.0.0-5443-exec-2] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Scheduling stop procedure for stream: NewUser_QffUUA7emG
2024-08-04 20:49:36,219 [pool-298-thread-1] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Executing stop procedure for stream: NewUser_QffUUA7emG
2024-08-04 20:49:36,220 [network_thread - 7547] INFO  io.antmedia.webrtc.adaptor.Adaptor - Ice connection state changed to CLOSED so it's stopping
2024-08-04 20:49:36,220 [network_thread - 7547] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Stopped already called. It's returning for stream: NewUser_QffUUA7emG
2024-08-04 20:49:36,228 [NioProcessor-12] INFO  o.r.server.net.rtmp.BaseRTMPHandler - connectionClosed: GZBK5LBFWEBJZ
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  o.r.server.net.rtmp.RTMPConnection - Closing stream: 1 publish name:null
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  o.red5.server.stream.StreamService - deleteStream with internal id:1 is closing
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  o.r.s.stream.ClientBroadcastStream - Checking mux adaptor to stop NewUser_QffUUA7emG
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  io.antmedia.muxer.MuxAdaptor - Calling stop for NewUser_QffUUA7emG input queue size:4
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  o.r.s.stream.ClientBroadcastStream - Mux Adaptor stop called NewUser_QffUUA7emG
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  i.a.AntMediaApplicationAdapter - W3C x-category:stream x-event:unpublish c-ip:127.0.0.1 cs-bytes:136788 sc-bytes:3593 x-sname:9137d119-05b9-4477-80ea-7891fbd17451 x-file-length:2 x-name:NewUser_QffUUA7emG
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  i.a.AntMediaApplicationAdapter - W3C x-category:session x-event:disconnect c-ip:127.0.0.1 c-client-id:90
2024-08-04 20:49:36,229 [NioProcessor-12] INFO  o.r.server.net.rtmp.BaseRTMPHandler - connectionClosed: GZBK5LBFWEBJZ
2024-08-04 20:49:36,231 [RTMPConnectionExecutor-1] WARN  o.red5.server.net.rtmp.RTMPHandler - Not connected, closing connection
2024-08-04 20:49:36,231 [RTMPConnectionExecutor-1] WARN  o.red5.server.net.rtmp.RTMPHandler - Not connected, closing connection
2024-08-04 20:49:36,232 [vert.x-worker-thread-22] WARN  io.antmedia.muxer.MuxAdaptor - closing adaptor for NewUser_QffUUA7emG 
2024-08-04 20:49:36,232 [vert.x-worker-thread-22] INFO  io.antmedia.muxer.MuxAdaptor - close resources for streamId -> NewUser_QffUUA7emG
2024-08-04 20:49:36,232 [vert.x-worker-thread-22] INFO  io.antmedia.muxer.MuxAdaptor - Cancelling packet poller task(id:204) for streamId: NewUser_QffUUA7emG
2024-08-04 20:49:36,232 [vert.x-worker-thread-22] WARN  io.antmedia.muxer.MuxAdaptor - closed adaptor for NewUser_QffUUA7emG
2024-08-04 20:49:36,232 [vert.x-worker-thread-22] INFO  i.a.AntMediaApplicationAdapter - Closing broadcast stream id: NewUser_QffUUA7emG
2024-08-04 20:49:36,236 [vert.x-worker-thread-22] INFO  i.a.AntMediaApplicationAdapter - Deleting streamId:NewUser_QffUUA7emG because it's a zombi stream
2024-08-04 20:49:36,236 [vert.x-worker-thread-22] INFO  i.a.AntMediaApplicationAdapter - Leaving closeBroadcast for streamId:NewUser_QffUUA7emG
2024-08-04 20:49:39,724 [https-jsse-nio2-0.0.0.0-5443-exec-1] INFO  i.a.webrtc.adaptor.RTMPAdaptor - Stopped already called. It's returning for stream: NewUser_QffUUA7emG

There are also these browser console logs:

Video sender not found to change bandwidth. Streaming may not be active
Received pong from server
--isRecordingFeatureAvailable:  false
***** no_stream_exist
Received pong from server
--isRecordingFeatureAvailable:  false
iceConnectionState Changed:  {"state":"disconnected","streamId":"fsaf_d2CGkZrbzZ"}
***** no_stream_exist
**** publish started:true
iceConnectionState Changed:  {"state":"checking","streamId":"fsfafas_arLiBqrasC"}
iceConnectionState Changed:  {"state":"connected","streamId":"fsfafas_arLiBqrasC"}
burak-58 commented 1 month ago

Hi @Evert-jvv, Thanks for creating the issue. I couldn't understand what your issue is. Could you please add the report as in this issue templete?

Evert-jvv commented 1 month ago

Hi @burak-58, Thank you, I have updated the issue with the provided template.

Evert-jvv commented 1 month ago

I managed to get it working by using the enterprise version. Does the conference app only work on enterprise?