Open kalvinGit opened 2 years ago
Hi,
Maybe rtsp client is not receiving any data. Increasing log may helps you to know this.
Best regards Michel
When I play a video on the web, I print a lot of this log in the background:
[148856:997][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=6a70615165796755412f7a33, use_candidate=0, nomination=0
A complete log:
...omit
...omit
...omit
[148856:997][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=6a70615165796755412f7a33, use_candidate=0, nomination=0
[148857:046][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=6542456c646f2f784173472f, use_candidate=0, nomination=0
[148857:095][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=497a66796842373764525535, use_candidate=0, nomination=0
[148857:143][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=374579576549394c71622f46, use_candidate=0, nomination=0
[148857:192][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=33477a413547564a50714d33, use_candidate=0, nomination=0
[148857:240][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=64575974526f676f4e79357a, use_candidate=0, nomination=0
[148857:288][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=735a7470374d575a4644736c, use_candidate=0, nomination=0
[148857:336][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=5542356e79324b2b44554833, use_candidate=0, nomination=0
[148857:385][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=5633484a3943584e56736761, use_candidate=0, nomination=0
[148857:433][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=66674b662b71727745325248, use_candidate=0, nomination=0
[148857:481][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=366478646e545661484b3562, use_candidate=0, nomination=0
[148857:529][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=33336a4b546e58506935694c, use_candidate=0, nomination=0
[148857:578][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=6c6c617a4f5a37416569714c, use_candidate=0, nomination=0
[148857:626][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=354779634c30384846307a45, use_candidate=0, nomination=0
[148857:674][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=595a664f46696f6479613353, use_candidate=0, nomination=0
[148857:722][9] (connection.cc:828): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C--I|-|0|0|7205793488602807806|-]: Timed out after 15019 ms without a response, rtt=6000
[148857:722][9] (connection.cc:1165): Conn[7803ec90:0:Net[eth0:172.18.112.x/20:Ethernet:id=1]:GToyXCyW:1:0:local:udp:172.18.118.x:41116->tYgzJIpB:1:1677729535:stun:udp:202.43.232.x:53613|C-xI|-|0|0|7205793488602807806|-]: Sent STUN BINDING request, id=4a662b384a41567639423345, use_candidate=0, nomination=0
[148857:722][9] (p2p_transport_channel.cc:1923): Channel[0|1|__]: Transport channel state changed from 2 to 3
[148857:722][9] (jsep_transport_controller.cc:1211): 0 Transport 1 state changed. Check if state is complete.
[148857:722][9] (jsep_transport_controller.cc:1211): 0 Transport 1 state changed. Check if state is complete.
[148857:722][9] (connection.cc:1214): Connection deleted with number of pings sent: 312
[148857:722][1] (peer_connection.cc:1812): Changing IceConnectionState 1 => 4
[148857:722][9] (p2p_transport_channel.cc:2118): Channel[0|1|__]: Removed connection 7803ec90 (0 remaining)
[148857:723][1] (PeerConnectionManager.h:238): virtual void PeerConnectionManager::PeerConnectionObserver::OnIceConnectionChange(webrtc::PeerConnectionInterface::IceConnectionState) state:4 peerid:0.48689907647289643
[148857:723][1] (peer_connection.cc:1831): Changing standardized IceConnectionState 1 => 4
[148857:723][108] (PeerConnectionManager.cpp:765): hangUp 0.48689907647289643
[148857:723][108] (PeerConnectionManager.cpp:774): Remove PeerConnection peerid:0.48689907647289643
[148857:723][108] (PeerConnectionManager.cpp:791): hangUp stream is no more used 9712277819617665721
[148857:723][108] (PeerConnectionManager.cpp:799): hangUp stream closed 9712277819617665721
[148857:723][1] (webrtc_video_engine.cc:1322): SetVideoSend (ssrc= 3585895761, options: nullptr, source = nullptr)
[148857:723][1] (livevideosource.h:59): LiveVideoSource::stop
[148857:723][103] (video_stream_encoder.cc:2176): Updating sink restrictions from <null> to { }
[148857:723][103] (resource_adaptation_processor.cc:144): Removing resource "QualityScalerResource".
[148857:723][103] (video_stream_adapter.cc:237): Resetting restrictions
[148857:727][1] (VideoDecoder.h:86): VideoDecoder::stop
Close session: video/H264
Sending request: TEARDOWN rtsp://admin:admin123@14.23.143.176:554/cam/realmonitor?channel=1&subtype=0/ RTSP/1.0
CSeq: 7
Authorization: Digest username="admin", realm="Login to cf0e1240aca6434e5973142f52b4c7fa", nonce="4bc40d1959c873f67ab3574b11041872", uri="rtsp://admin:admin123@14.23.143.176:554/cam/realmonitor?channel=1&subtype=0/", response="0ceec1d03396c0d2404d8205446e5786"
User-Agent: LIVE555 Streaming Media v2021.11.01
Session: 1536944961803
[148857:736][1] (PeerConnectionManager.h:229): virtual void PeerConnectionManager::PeerConnectionObserver::OnRenegotiationNeeded() peerid:0.48689907647289643
[148857:736][108] (PeerConnectionManager.h:188): virtual PeerConnectionManager::PeerConnectionObserver::~PeerConnectionObserver()
[148857:737][1] (webrtc_video_engine.cc:2624): VideoSendStream stats: 19089827182, {input_fps: 28, encode_fps: 0, encode_ms: 0, encode_usage_perc: 0, target_bps: 0, media_bps: 0, suspended: false, bw_adapted_res: false, cpu_adapted_res: false, bw_adapted_fps: false, cpu_adapted_fps: false, #cpu_adaptations: 0, #quality_adaptations: 1} {ssrc: 3585895761, type: media, width: 0, height: 0, key: 0, delta: 0, total_bps: 0, retransmit_bps: 0, avg_delay_ms: 0, max_delay_ms: 0, nack: 0, fir: 0, pli: 0}
[148857:737][1] (webrtc_video_engine.cc:1681): Call stats: 19089827182, {send_bw_bps: 0, recv_bw_bps: 0, max_pad_bps: 0, pacer_delay_ms: 0, rtt_ms: -1}
[148857:737][1] (PeerConnectionManager.h:238): virtual void PeerConnectionManager::PeerConnectionObserver::OnIceConnectionChange(webrtc::PeerConnectionInterface::IceConnectionState) state:6 peerid:0.48689907647289643
[148857:737][1] (sdp_offer_answer.cc:2479): Session: 3881322336584298653 Old state: stable New state: closed
[148857:737][1] (PeerConnectionManager.h:235): virtual void PeerConnectionManager::PeerConnectionObserver::OnSignalingChange(webrtc::PeerConnectionInterface::SignalingState) state:5 peerid:0.48689907647289643
[148857:737][1] (webrtc_video_engine.cc:1647): SetDefaultSink: nullptr
[148857:737][1] (channel.cc:522): Channel disabled: {mid: 1, media_type: video}
[148857:737][1] (channel.cc:974): Changing video state, send=0 for {mid: 1, media_type: video}
[148857:737][9] (rtp_demuxer.cc:241): Removed sink = 8f518aa0 bindings
[148857:737][103] (resource_adaptation_processor.cc:144): Removing resource "EncoderUsageResource".
[148857:745][98] (video_send_stream_impl.cc:368): VideoSendStreamImpl::Stop
[148857:745][1] (video_send_stream_impl.cc:299): ~VideoSendStreamImpl: {encoder_settings: { experiment_cpu_load_estimator: off}}, rtp: {ssrcs: [3585895761], rids: [], mid: '1', rtcp_mode: RtcpMode::kReducedSize, max_packet_size: 1200, extmap-allow-mixed: true, extensions: [{uri: http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01, id: 3}, {uri: http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time, id: 2}, {uri: http://www.webrtc.org/experiments/rtp-hdrext/color-space, id: 8}, {uri: http://www.webrtc.org/experiments/rtp-hdrext/playout-delay, id: 5}, {uri: http://www.webrtc.org/experiments/rtp-hdrext/video-content-type, id: 6}, {uri: http://www.webrtc.org/experiments/rtp-hdrext/video-timing, id: 7}, {uri: urn:3gpp:video-orientation, id: 13}, {uri: urn:ietf:params:rtp-hdrext:sdes:mid, id: 4}, {uri: urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id, id: 11}, {uri: urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id, id: 10}], lntf: {enabled: false}, nack: {rtp_history_ms: 1000}, ulpfec: {ulpfec_payload_type: 116, red_payload_type: 114, red_rtx_payload_type: 115}, payload_name: VP8, payload_type: 96, raw_payload: false, flexfec: {payload_type: -1, ssrc: 0, protected_media_ssrcs: []}, rtx: {ssrcs: [1191343266], payload_type: 97}, c_name: wAsAioqScFpfS/1m}, rtcp_report_interval_ms: 1000, send_transport: (Transport), render_delay_ms: 0, target_delay_ms: 0, suspend_below_min_bitrate: off}
[148857:750][1] (send_statistics_proxy.cc:667): WebRTC.Video.InputWidthInPixels 1920
WebRTC.Video.InputHeightInPixels 1080
WebRTC.Video.InputFramesPerSecond periodic_samples:7, {min:22, avg:23, max:25}
Frames encoded 0
WebRTC.Video.DroppedFrames.Capturer 0
WebRTC.Video.DroppedFrames.EncoderQueue 334
WebRTC.Video.DroppedFrames.Encoder 0
WebRTC.Video.DroppedFrames.Ratelimiter 0
WebRTC.Video.DroppedFrames.CongestionWindow 0
[148857:750][1] (channel.cc:522): Channel disabled: {mid: 0, media_type: audio}
[148857:750][1] (channel.cc:818): Changing voice state, recv=0 send=0 for {mid: 0, media_type: audio}
[148857:750][9] (rtp_demuxer.cc:241): Removed sink = 8f515410 bindings
[148857:750][9] (peer_connection.cc:2432): Tearing down data channel transport for mid=2
[148857:751][1] (peer_connection.cc:546): Session: 3881322336584298653 is destroyed.
[148857:751][1] (dtmf_sender.cc:240): The Dtmf provider is deleted. Clear the sending queue.
Can you figure out what the problem is?
Thanks!
Hi,
We don't see any data coming from RTSP/RTP, there is no message "LiveVideoSource:onData", either your rtsp source doesnot support RTP over TCP or it doesnot send data.
Best Regards, Michel.
I also meet this issue, I use different machines running in docker at a same version, a docker running in a machine in North America produces the same error log, the device of rtsp source is developed in North Americam, but when I use a machine in China to connect the RTSP source from the monitor device , it can perform well althoungh a lit bit delay. It seems existing some limitations about the network of my machine, but this log doesn't provide valuable information for us to shot the trouble. Is there any way to fix it?
I have fixed it by changing the UDP port setting and eliminating the restriction of access of the UDP port, because WebRTC uses the port for UDP protocol randomly, you need to open all of the ports for clients to access.
Unable to play rtsp streams when started in docker mode
environment:
1.docker run webrtc-streamer
sudo docker run -d --rm --network=host --name=wrs mpromonet/webrtc-streamer:v0.6.5 -v -H 8999 "rtsp://admin:admin123@14.23.143.176:554/cam/realmonitor?channel=1&subtype=0"
2.Unable to play rtsp log:Please help me.
Thanks!