Need help with Error

[Jean Paul Talledo Vilela]

Hi

I am using Ant Media Enterprise Edition and trying to test a streaming using the following python script

https://github.com/socieboy/webrtc-ant-media/blob/master/webrtc.py

I am getting some errors that I am not familiar with and would like to get some advise how to get the pipeline working

Python Script output:

Client Connect
Inititialized
Message: start
Creating WebRTC Pipeline
Negotiation Needed
Offer Created
Send SDP Offer
Message: error
Message: notSetRemoteDescription
Message: error
Message: publishTimeoutError
Message: notification
publish_finished

Ant Media Console Log output

2021-12-09 17:24:01,411 [vert.x-eventloop-thread-0] INFO i.antmedia.statistic.StatsCollector - System cpu load:0 process cpu load:0 available memory: 6559204 KB used memory(RSS): 603868 KB
2021-12-09 17:24:01,411 [vert.x-eventloop-thread-0] INFO i.antmedia.statistic.StatsCollector - Vertx worker queue size:0 WebRTCVertx worker queue size:0
2021-12-09 17:24:58,711 [https-jsse-nio2-0.0.0.0-5443-exec-10] ERROR i.a.e.w.WebSocketEnterpriseHandler - Error: EOFException:
2021-12-09 17:24:59,615 [https-jsse-nio2-0.0.0.0-5443-exec-5] INFO i.a.e.s.WebSocketLocalHandler - Web Socket opened
2021-12-09 17:24:59,619 [https-jsse-nio2-0.0.0.0-5443-exec-4] INFO i.a.e.w.WebSocketEnterpriseHandler - received token:null
2021-12-09 17:24:59,619 [https-jsse-nio2-0.0.0.0-5443-exec-4] INFO i.a.e.w.c.VirtualVideoEncoderFactory - Adding H264 Encoder to the supported codecs
2021-12-09 17:24:59,639 [https-jsse-nio2-0.0.0.0-5443-exec-4] INFO io.antmedia.muxer.MuxAdaptor - serverSettings exist io.antmedia.settings.ServerSettings@304ca3c3
2021-12-09 17:24:59,749 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - before prepare for frank-edge hash: 2045025747
2021-12-09 17:24:59,750 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO io.antmedia.muxer.HLSMuxer - hls time: 2, hls list size: 5
2021-12-09 17:24:59,750 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO i.a.e.adaptive.StreamAdaptor - Stream adaptor scheduled job id 29 stream adaptor:989209659 for stream:frank-edge
2021-12-09 17:24:59,750 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO i.a.e.adaptive.audio.AACEncoder - name : aac
2021-12-09 17:24:59,752 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO io.antmedia.muxer.HLSMuxer - copy codec parameter from context 0 stream index: 0
2021-12-09 17:24:59,752 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO i.a.e.adaptive.audio.OpusEncoder - encoder name libopus source sample rate 44100, channel layout 3
2021-12-09 17:24:59,752 [https-jsse-nio2-0.0.0.0-5443-exec-9] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - after prepare for frank-edge hash:2045025747
2021-12-09 17:24:59,752 [vert.x-eventloop-thread-7] INFO org.webrtc.Logging - Tag:NativeLibrary - Message:Native library has already been loaded.
2021-12-09 17:24:59,752 [vert.x-eventloop-thread-7] INFO org.webrtc.Logging - Tag:PeerConnectionFactory - Message:PeerConnectionFactory was initialized without an injected Loggable. Any existing Loggable will be deleted.
2021-12-09 17:24:59,752 [vert.x-eventloop-thread-7] INFO org.webrtc.Logging - Tag:JavaAudioDeviceModule - Message:createAudioDeviceModule
2021-12-09 17:24:59,752 [vert.x-eventloop-thread-7] INFO org.webrtc.Logging - Tag:JavaAudioDeviceModule - Message:HW NS will not be used.
2021-12-09 17:24:59,752 [vert.x-eventloop-thread-7] INFO org.webrtc.Logging - Tag:JavaAudioDeviceModule - Message:HW AEC will not be used.
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,753 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,754 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,754 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,754 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,754 [https-jsse-nio2-0.0.0.0-5443-exec-9] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,754 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,755 [https-jsse-nio2-0.0.0.0-5443-exec-3] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. PeerConnection null
2021-12-09 17:24:59,756 [network_thread - 14991] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - onSetFailure: Failed to set remote offer sdp: Failed to set remote video description send parameters.
2021-12-09 17:24:59,757 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,757 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,757 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,757 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:24:59,758 [https-jsse-nio2-0.0.0.0-5443-exec-7] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - Ice candidate will be added later for stream Id frank-edge. Remote Description not set
2021-12-09 17:25:04,645 [vert.x-eventloop-thread-0] WARN i.a.e.adaptive.WebRTCEncoderAdaptor - WebRTC ingest is not started. So publish timeout is firing for stream: frank-edge
2021-12-09 17:25:04,645 [vert.x-eventloop-thread-0] ERROR i.a.e.w.WebRTCPublishStreamInfoListener - Publish timeout error for stream:frank-edge
2021-12-09 17:25:04,646 [vert.x-eventloop-thread-0] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - entering stop() for frank-edge
2021-12-09 17:25:04,646 [vert.x-eventloop-thread-7] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - Encoder health check is returning because encoder adaptor is stopped for frank-edge
2021-12-09 17:25:04,646 [vert.x-eventloop-thread-7] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - running stop operations in executor for stream: frank-edge Received audio frame: 0 Processed audio frame: 0Received video frame: 0 Processed video frame: 0
2021-12-09 17:25:04,646 [vert.x-eventloop-thread-7] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - Publish Stats StreamId: frank-edge TransferedByte: 0 Stream Duration: 1639070704646 Bitrate: 0 Source IP: null User-Agent: N/A
2021-12-09 17:25:04,686 [network_thread - 14991] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - onIceConnectionChange CLOSED for streamId: frank-edge hash:2045025747
2021-12-09 17:25:04,686 [network_thread - 14991] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - entering stop() for frank-edge
2021-12-09 17:25:04,686 [network_thread - 14991] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - Encoder is already stopped, returning for frank-edge
2021-12-09 17:25:04,687 [vert.x-eventloop-thread-7] INFO i.a.e.adaptive.WebRTCEncoderAdaptor - leaving stop() for frank-edge
2021-12-09 17:25:04,688 [vert.x-eventloop-thread-7] INFO i.a.AntMediaApplicationAdapter - Closing broadcast stream id: frank-edge
2021-12-09 17:25:04,691 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Recording set to false in streamadaptor: 989209659 for stream: frank-edge stopping scheduler job id: 29
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Flushing video encoder:SFUForwarder for stream adaptor:989209659 stream id:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:aac for stream adaptor:989209659 stream id:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Flushing audio encoder:libopus for stream adaptor:989209659 stream id:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.enterprise.webrtc.WebRTCAdaptor - unregistering frank-edge muxer with 0p and codec: H265 from webrtc adaptor
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] WARN io.antmedia.muxer.HLSMuxer - HLSMuxer trailer is returning because it's not correct state. Isrunning: false, outputformatContext: org.bytedeco.ffmpeg.avformat.AVFormatContext[address=0x7fc9c42cd440,position=0,limit=0,capacity=0,deallocator=null]
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.video.SFUForwarder - Video codec writing trailer name: SFUForwarder height:480 for stream:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.video.SFUForwarder - Total processing time 0 ms Average processing time 0 ms per frame for stream:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] WARN io.antmedia.muxer.HLSMuxer - HLSMuxer trailer is returning because it's not correct state. Isrunning: false, outputformatContext: org.bytedeco.ffmpeg.avformat.AVFormatContext[address=0x7fc9c42cd440,position=0,limit=0,capacity=0,deallocator=null]
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.audio.AACEncoder - writing trailer codec name: aac bitrate:96000 for stream:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.audio.OpusEncoder - writing trailer codec name: libopus bitrate:96000 for stream:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.audio.OpusEncoder - Total processing time 0, Average processing time 0 ms per frame on average for stream:frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Average thread entrance interval 9ms for stream: frank-edge
2021-12-09 17:25:04,692 [vert.x-worker-thread-12] INFO i.a.e.adaptive.StreamAdaptor - Leaving streamadaptor: 989209659 for stream: frank-edge

[Yash]

Hi Jean,

Hope you are fine.

It is showing publish time out error. It might be because of many reasons, please make sure that UDP ports 5000-65000 should be whitelisted on your firewall.

You can also check the WebRTC streaming by following https://github.com/ant-media/Ant-Media-Server/wiki/WebRTC-Publishing 

 

Regards,

Yash