Description: Occasionally, during a call, a subscriber stream will be shown as black on the receiving end while the publisher still sees his video stream. Other participants keep working as should.
This issue is intermittent but it does happen.
Platforms: The issue occurred on iOS Safari, and Chrome on Mac and Windows.
The only relatable error from the server would be this.
openvidu-server_1 | [WARN] 2021-04-12 08:06:12,403 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.kurento.core.KurentoSessionManager - PARTICIPANT con_Axm6jjNsXY: Error unpublishing media openvidu-server_1 | io.openvidu.client.OpenViduException: Participant 'con_Axm6jjNsXY' is not streaming media. Code: 105 openvidu-server_1 | at io.openvidu.server.kurento.core.KurentoSessionManager.unpublishVideo(KurentoSessionManager.java:486) openvidu-server_1 | at io.openvidu.server.rpc.RpcHandler.unpublishVideo(RpcHandler.java:422) openvidu-server_1 | at io.openvidu.server.rpc.RpcHandler.handleRequest(RpcHandler.java:140) openvidu-server_1 | at org.kurento.jsonrpc.internal.JsonRpcHandlerManager.handleRequest(JsonRpcHandlerManager.java:142) openvidu-server_1 | at org.kurento.jsonrpc.internal.server.ProtocolManager$3.run(ProtocolManager.java:218) openvidu-server_1 | at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) openvidu-server_1 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) openvidu-server_1 | at java.lang.Thread.run(Thread.java:748) openvidu-server_1 | [INFO] 2021-04-12 08:06:13,072 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.rpc.RpcHandler - Participant con_Axm6jjNsXY is calling method 'publish' in session 3BySdXWh3JDGcu05rXTe0Z openvidu-server_1 | [INFO] 2021-04-12 08:06:13,087 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_Axm6jjNsXY: Request to publish video in room 3BySdXWh3JDGcu05rXTe0Z (sdp type OFFER) openvidu-server_1 | [INFO] 2021-04-12 08:06:13,097 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_Axm6jjNsXY: Is now publishing video in room 3BySdXWh3JDGcu05rXTe0Z openvidu-server_1 | [INFO] 2021-04-12 08:06:13,111 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.rpc.RpcHandler - Participant con_Axm6jjNsXY is calling method 'publish' in session 3BySdXWh3JDGcu05rXTe0Z openvidu-server_1 | [INFO] 2021-04-12 08:06:13,163 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t1047] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: str_CAM_RcER_con_Axm6jjNsXY (publisher) | state: GATHERING | componentId: 1 | streamId: 1 | timestamp: 1618214773110 openvidu-server_1 | [INFO] 2021-04-12 08:06:13,164 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t1050] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: str_CAM_RcER_con_Axm6jjNsXY (publisher) | state: GATHERING | componentId: 2 | streamId: 1 | timestamp: 1618214773162 openvidu-server_1 | [INFO] 2021-04-12 08:06:13,169 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_Axm6jjNsXY: Request to publish video in room 3BySdXWh3JDGcu05rXTe0Z (sdp type OFFER) openvidu-server_1 | [ERROR] 2021-04-12 08:06:13,171 [SessionHandler-a9cuag9vpaskcbot0kf8rjohel-e60-t0] org.kurento.jsonrpc.internal.JsonRpcHandlerManager - Exception while processing request {"id":90,"method":"publishVideo","params":{"doLoopback":false,"hasAudio":true,"hasVideo":true,"audioActive":true,"videoActive":true,"typeOfVideo":"CAMERA","frameRate":-1,"videoDimensions":"{\"width\":1280,\"height\":720}","sdpOffer":"v=0\r\no=- 3782753748933715924 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 9 0 8 105 13 110 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:Frco\r\na=ice-pwd:UKr8/441iy9zndD6jspVUKKh\r\na=ice-options:trickle\r\na=fingerprint:sha-256 23:81:47:CC:84:B4:29:FC:08:E8:9D:BB:21:1C:A6:74:FF:59:70:CA:9C:A9:21:64:49:BB:32:D8:EE:D0:78:57\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7 db6a2423-65db-4e3e-9d93-b52510c010ec\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:3071853615 cname:J5LWw2ExGPHJc/CT\r\na=ssrc:3071853615 msid:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7 db6a2423-65db-4e3e-9d93-b52510c010ec\r\na=ssrc:3071853615 mslabel:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7\r\na=ssrc:3071853615 label:db6a2423-65db-4e3e-9d93-b52510c010ec\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 123 104\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:Frco\r\na=ice-pwd:UKr8/441iy9zndD6jspVUKKh\r\na=ice-options:trickle\r\na=fingerprint:sha-256 23:81:47:CC:84:B4:29:FC:08:E8:9D:BB:21:1C:A6:74:FF:59:70:CA:9C:A9:21:64:49:BB:32:D8:EE:D0:78:57\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13 urn:3gpp:video-orientation\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7 3dcc3efa-ce8f-47aa-82a9-e999d170d6a5\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98 VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98 transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98 nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:100 H264/90000\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:102 red/90000\r\na=rtpmap:123 rtx/90000\r\na=fmtp:123 apt=102\r\na=rtpmap:104 ulpfec/90000\r\na=ssrc-group:FID 3350750893 2163611849\r\na=ssrc:3350750893 cname:J5LWw2ExGPHJc/CT\r\na=ssrc:3350750893 msid:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7 3dcc3efa-ce8f-47aa-82a9-e999d170d6a5\r\na=ssrc:3350750893 mslabel:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7\r\na=ssrc:3350750893 label:3dcc3efa-ce8f-47aa-82a9-e999d170d6a5\r\na=ssrc:2163611849 cname:J5LWw2ExGPHJc/CT\r\na=ssrc:2163611849 msid:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7 3dcc3efa-ce8f-47aa-82a9-e999d170d6a5\r\na=ssrc:2163611849 mslabel:yU9ECatk63Z6xi9XDCjrrbVH8ZyBtvslgVM7\r\na=ssrc:2163611849 label:3dcc3efa-ce8f-47aa-82a9-e999d170d6a5\r\n"},"jsonrpc":"2.0"} openvidu-server_1 | org.kurento.client.internal.server.KurentoServerException: Endpoint already negotiated (Code:40208, Type:null, Data: {"type":"SDP_END_POINT_ALREADY_NEGOTIATED"})