Deployment working, but ICE candidate-it seems like you turn server is broken. in specific situation

OpenVidu v2 Issues with deployment
1

Hello,

I have a pre-production deployment in ubuntu server working fine, but I noticed that when an user starts screensharing, it works in local and remote. But when this user stops the screensharing and starts it again with another screen, the remote user got a grey screen and the browser console says: ICE candidate-it seems like you turn server is broken.

Apparently, my turn server is fine and restart it is not solving this problem. This happens for someone before? I want to solve it before going to production and it’s not easy to debug.

Thanks in advance

2

Hello,

It seems like a weird problem, it never happened before.

Please, can you give more information about your problem?

  1. Browser that you are using.

  2. Logs from the browser, OpenVidu and Kurento when the problem happens.

On the other hand, try to replicate this problem in other browsers, to also check if it’s something related with that.

Regards!

3

Ok.

  1. I was using Firefox ESR and Chromium (in debian). It happens in both cases. Another colleague was using chrome in windows (it happens too).
    2.
    ChromiumICECandidate
    ChromiumICECandidate1352×929 90.4 KB
    T
    This is the error message in chromium console. The another one “ICE candidate fails- yout urn server appears to be broken” was in Firefox ESR

about:webrtc
about:webrtc3840×1080 608 KB

Info about webrtc in firefox ESR case.

I have the webrtc-internals-dump.txt for chromium because the screenshot it’s not so useful. It is long. You want that I paste it?

I did a tail for openvidu server and kurento media server logs. I can’t see anything important here:

KMS

2020-01-17T14:00:57,844151 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 93ed88a2-1105-43d1-a0a1-52d79b0e7d3b
2020-01-17T14:01:23,033888 27034 0x00007efba4ec0700 warning dtlsconnection gstdtlsconnection.c:312 handle_timeout() GstDtlsConnection@0x7efbdc0ae9e0 handling timeout failed
2020-01-17T14:01:57,844362 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 600fb62d-d6ee-48ea-b53d-abdcaacbd2db
2020-01-17T14:01:57,844576 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:302 keepAliveSessions() Session should be removed 600fb62d-d6ee-48ea-b53d-abdcaacbd2db
2020-01-17T14:01:57,844629 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 93ed88a2-1105-43d1-a0a1-52d79b0e7d3b
2020-01-17T14:02:23,091562 27034 0x00007efba4ec0700 warning dtlsconnection gstdtlsconnection.c:312 handle_timeout() GstDtlsConnection@0x7efbdc0ae9e0 handling timeout failed
2020-01-17T14:02:57,844894 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 600fb62d-d6ee-48ea-b53d-abdcaacbd2db
2020-01-17T14:02:57,845108 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:302 keepAliveSessions() Session should be removed 600fb62d-d6ee-48ea-b53d-abdcaacbd2db
2020-01-17T14:02:57,845218 27034 0x00007efc401d1700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 93ed88a2-1105-43d1-a0a1-52d79b0e7d3b
2020-01-17T14:03:23,146078 27034 0x00007efba4ec0700 warning dtlsconnection gstdtlsconnection.c:312 handle_timeout() GstDtlsConnection@0x7efbdc0ae9e0 handling timeout failed

OV Server logs

[WARN] 2020-01-17 12:55:19,606 [entExec-e4-t277] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:00:19,621 [entExec-e4-t278] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:05:19,632 [entExec-e4-t279] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:10:19,691 [entExec-e4-t280] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:15:19,760 [entExec-e4-t281] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:20:19,774 [entExec-e4-t282] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:25:19,825 [entExec-e4-t283] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:30:19,925 [entExec-e4-t284] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:35:20,022 [entExec-e4-t285] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento
[WARN] 2020-01-17 13:40:20,110 [entExec-e4-t286] io.openvidu.server.kurento.kms.KmsManager (disconnected) - Kurento Client disconnected from KMS KMS-OWDRFP with uri ws://localhost:8888/kurento

Thanks for the answer!

Beka

4

Hello Beka,

From what I can see in the logs it does not seem like an error related with the turn/stun server. From OpenVidu logs it seems like the connection between OpenVidu and Kurento is over for an unknown reason. With this logs we can not see what’s the reason of the disconnection.

Could you please, give us more logs with the system working correctly and during this error? Also, to make sure that everything is correctly set up with your coturn, you can test it in this webpage: https://webrtc.github.io/samples/src/content/peerconnection/trickle-ice/ , but it does not seem to be this problem.

More information about your configuration will be helpful, like your configuration parameters, open ports… etc

Best Regards,

Carlos.

5

Hello Carlos,

I was testing CoTurn in that webpage when I was deploying the pre-production system and it seems ok. I can see in the logs Coturn initialization and how it generate a random username and credentials each time. I agree that it seems ok, because of that I got confused with the browser console error.

I have 80, 443, 4443 TCP, 3478 TCP and 40000-65535 UPD and TCP open ports. Regarding KMS-OV Server and Coturn I don’t have any special configuration. I was following your documentation. It works really well, with the only exception about this bug (start screensharing after another start and stop screensharing. The first screensharing works fine, the second one not).My specific configurations are about MEAN architecture configurations, not Openvidu architecture ones.

About logs I was replicating the error and comparing the logs several times and I got this. Starting scrensharing after starting it and stopping it introduces always these lines:

2550787591 1 tcp 1518280447 192.168.10.163 9 typ host tcptype active generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,485863 32275 0x00007f94627ec700 info webrtcendpoint kmswebrtcendpoint.c:278 new_selected_pair_full() New candidate pair selected, local: ‘candidate:7 1 UDP 1677722111 84.88.36.225 14578 typ srflx raddr 192.168.114.233 rport 14578’, remote: ‘candidate:436677988 1 UDP 1686052607 147.83.206.88 51972 typ srflx raddr 192.168.10.163 rport 51972’, stream_id: ‘1’, component_id: 1
2020-01-21T13:31:16,417985 32275 0x00007f94627ec700 info kmsutils kmsutils.c:494 kms_utils_pad_monitor_gaps() <’’:sink_video_default> Add probe: Detect stream gaps
2020-01-21T13:31:26,856348 32275 0x00007f9476ffd700 warning rtpsource rtpsource.c:1147 update_receiver_stats() duplicate or reordered packet (seqnr 10897, expected 10900

6

Here the output from tail -n100 KMS log:

a=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 red/90000
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:102 ulpfec/90000

2020-01-21T13:31:15,402443 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94c800f300 Add format support, media: audio, codec: opus/48000/2
2020-01-21T13:31:15,402532 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94c800f300 Add format support, media: audio, codec: PCMU/8000
2020-01-21T13:31:15,402654 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94c800f300 Add format support, media: video, codec: VP8/90000
2020-01-21T13:31:15,402703 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94c800f300 Add format support, media: video, codec: H264/90000
2020-01-21T13:31:15,405604 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94b0018780 Add format support, media: audio, codec: opus/48000/2
2020-01-21T13:31:15,405688 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94b0018780 Add format support, media: audio, codec: PCMU/8000
2020-01-21T13:31:15,405724 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94b0018780 Add format support, media: video, codec: VP8/90000
2020-01-21T13:31:15,405756 32275 0x00007f94f9c25700 info sdprtpavpmediahandler kmssdprtpavpmediahandler.c:1249 kms_sdp_rtp_avp_media_handler_add_codec() KmsSdpRtpSavpfMediaHandler@0x7f94b0018780 Add format support, media: video, codec: H264/90000
2020-01-21T13:31:15,406790 32275 0x00007f94f9c25700 info kmssdpsession kmssdpsession.c:140 kms_sdp_session_process_offer() Generated SDP Answer:
v=0
o=- 3788602275 3788602275 IN IP4 0.0.0.0
s=Kurento Media Server
c=IN IP4 0.0.0.0
t=0 0
a=msid-semantic: WMS
a=group:BUNDLE 0 1
m=audio 1 UDP/TLS/RTP/SAVPF 111 0
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=sendonly
a=mid:0
a=rtcp:9 IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=rtpmap:0 PCMU/8000
a=setup:active
a=rtcp-mux
a=fmtp:111 minptime=10;useinbandfec=1
a=ssrc:573001075 cname:user3456449945@host-d7cdf2c4
a=ice-ufrag:XM7s
a=ice-pwd:WoxioRWX32/rXOIzt6swwr
a=fingerprint:sha-256 1E:60:E2:93:5E:98:BD:B2:8F:A6:A1:30:C6:26:E2:D3:56:16:34:46:9E:76:28:29:EA:B7:CD:5D:0C:72:98:6F
m=video 1 UDP/TLS/RTP/SAVPF 96
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=sendonly
a=mid:1
a=rtcp:9 IN IP4 0.0.0.0
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=setup:active
a=rtcp-mux
a=ssrc:3767480355 cname:user3456449945@host-d7cdf2c4
a=ice-ufrag:XM7s
a=ice-pwd:WoxioRWX32/rXOIzt6swwr
a=fingerprint:sha-256 1E:60:E2:93:5E:98:BD:B2:8F:A6:A1:30:C6:26:E2:D3:56:16:34:46:9E:76:28:29:EA:B7:CD:5D:0C:72:98:6F

2020-01-21T13:31:15,407481 32275 0x00007f94657f2700 fixme basesink gstbasesink.c:3125 gst_base_sink_default_event() stream-start event without group-id. Consider implementing group-id handling in the upstream elements
2020-01-21T13:31:15,408828 32275 0x00007f94f9c25700 info basertpendpoint kmsbasertpendpoint.c:1113 kms_base_rtp_endpoint_start_transport_send() Media ‘video’ has REMB
2020-01-21T13:31:15,408947 32275 0x00007f94f9c25700 info basertpendpoint kmsbasertpendpoint.c:1060 kms_base_rtp_endpoint_create_remb_manager() Creating REMB for session ID 0 (kmswebrtcendpoint33-sess0) and remote video SSRC 0
2020-01-21T13:31:15,409020 32275 0x00007f94f9c25700 info basertpendpoint kmsbasertpendpoint.c:1071 kms_base_rtp_endpoint_create_remb_manager() REMB: Set RTCP min interval to 500ms
2020-01-21T13:31:15,409436 32275 0x00007f94627ec700 fixme default gstutils.c:3766 gst_pad_create_stream_id_internal() nicesrc33:src Creating random stream-id, consider implementing a deterministic way of creating a stream-id
2020-01-21T13:31:15,409499 32275 0x00007f94f9c25700 info kmswebrtcsession kmswebrtcsession.c:1552 kms_webrtc_session_start_transport_send() Started transport for media: audio, index: 0
2020-01-21T13:31:15,409633 32275 0x00007f94f9c25700 info kmswebrtcsession kmswebrtcsession.c:1552 kms_webrtc_session_start_transport_send() Started transport for media: video, index: 1
2020-01-21T13:31:15,411831 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:415 kms_webrtc_endpoint_gather_candidates() Gather candidates for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,411910 32275 0x00007f94fb428700 info kmswebrtcsession kmswebrtcsession.c:797 kms_webrtc_session_gather_candidates() Gather candidates
2020-01-21T13:31:15,422506 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:3599373047 1 udp 2122260223 192.168.10.163 51972 typ host generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,422788 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:3599373047 1 udp 2122260223 192.168.10.163 58042 typ host generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,422966 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:436677988 1 udp 1686052607 147.83.206.88 51972 typ srflx raddr 192.168.10.163 rport 51972 generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,423125 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:436677988 1 udp 1686052607 147.83.206.88 58042 typ srflx raddr 192.168.10.163 rport 58042 generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,423277 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:2550787591 1 tcp 1518280447 192.168.10.163 9 typ host tcptype active generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,423425 32275 0x00007f94fb428700 info webrtcendpoint kmswebrtcendpoint.c:439 kms_webrtc_endpoint_add_ice_candidate() Add ICE candidate ‘candidate:2550787591 1 tcp 1518280447 192.168.10.163 9 typ host tcptype active generation 0 ufrag IGyc network-id 1’ for session ‘kmswebrtcendpoint33-sess0’
2020-01-21T13:31:15,485863 32275 0x00007f94627ec700 info webrtcendpoint kmswebrtcendpoint.c:278 new_selected_pair_full() New candidate pair selected, local: ‘candidate:7 1 UDP 1677722111 84.88.36.225 14578 typ srflx raddr 192.168.114.233 rport 14578’, remote: ‘candidate:436677988 1 UDP 1686052607 147.83.206.88 51972 typ srflx raddr 192.168.10.163 rport 51972’, stream_id: ‘1’, component_id: 1
2020-01-21T13:31:16,417985 32275 0x00007f94627ec700 info kmsutils kmsutils.c:494 kms_utils_pad_monitor_gaps() <’’:sink_video_default> Add probe: Detect stream gaps
2020-01-21T13:31:26,856348 32275 0x00007f9476ffd700 warning rtpsource rtpsource.c:1147 update_receiver_stats() duplicate or reordered packet (seqnr 10897, expected 10900)
2020-01-21T13:31:55,415983 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 6681ab8b-c194-4444-8e66-c497efc40d4b
2020-01-21T13:31:55,416191 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:302 keepAliveSessions() Session should be removed 6681ab8b-c194-4444-8e66-c497efc40d4b
2020-01-21T13:31:55,416245 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive eb39cfd3-aa8d-488d-acb2-9fbcd23e8619
2020-01-21T13:32:55,416496 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive 6681ab8b-c194-4444-8e66-c497efc40d4b
2020-01-21T13:32:55,416757 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:302 keepAliveSessions() Session should be removed 6681ab8b-c194-4444-8e66-c497efc40d4b
2020-01-21T13:32:55,416828 32275 0x00007f94f8422700 info KurentoWebSocketTransport WebSocketTransport.cpp:296 keepAliveSessions() Keep alive eb39cfd3-aa8d-488d-acb2-9fbcd23e8619

7

Here the output from tail -n100 OvServer logs:

[INFO] 2020-01-21 13:30:50,596 [0.0-4443-exec-2] io.openvidu.server.coturn.CoturnCredentialsService (createUser) - COTURN user created: true
[INFO] 2020-01-21 13:30:50,597 [0.0-4443-exec-2] io.openvidu.server.core.SessionManager (showTokens) - <SESSIONID, TOKENS>: {0mfymklhce1yj3gp={wss://hsjdvc.i2cat.net:4443?sessionId=0mfymklhce1yj3gp&token=kudra8wyj2yighdo&role=MODERATOR&version=2.11.0&turnUsername=DNVW14&turnCredential=dfdy8z=MODERATOR}, jotlkdqqdv9ldfze={}, fpipziyhreulrsa9={}, nrh7pzntwnbs2qqj={}, 0wczbtkeeqjx1blk={}, whms3pooswx1s2sy={wss://hsjdvc.i2cat.net:4443?sessionId=whms3pooswx1s2sy&token=hytmv10icsegdr6p&role=MODERATOR&version=2.11.0&turnUsername=7PODD7&turnCredential=gxhhma=MODERATOR}, eijwbor41wnrd3xl={}, r6am7hwkmf5tbohc={}, zce8xmzyk26axvea={}, sjd86hwtfniuo1ui={wss://hsjdvc.i2cat.net:4443?sessionId=sjd86hwtfniuo1ui&token=m9o7ukumydq8h7qu&role=SUBSCRIBER&version=2.11.0&turnUsername=TIRTOB&turnCredential=kv9jx2=SUBSCRIBER, wss://hsjdvc.i2cat.net:4443?sessionId=sjd86hwtfniuo1ui&token=fpnl6squqdqqul1e&role=MODERATOR&version=2.11.0&turnUsername=YTXHAQ&turnCredential=h62lz5=MODERATOR}}
[INFO] 2020-01-21 13:30:50,655 [0.0-4443-exec-4] io.openvidu.server.config.HttpHandshakeInterceptor (beforeHandshake) - Old HttpSession F6CE7DCC4C8A64727F6D47AD1C84BD67
[INFO] 2020-01-21 13:30:50,684 [.0-4443-exec-10] io.openvidu.server.rpc.RpcHandler (afterConnectionEstablished) - After connection established for WebSocket session: esm0csv8fcnhjpf717fav4hvrs
[INFO] 2020-01-21 13:30:50,685 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (joinRoom) - Final user reconnecting
[INFO] 2020-01-21 13:30:50,686 [v4hvrs-e1018-t0] io.openvidu.server.core.SessionManager (newParticipant) - Participant xsnldjrrb6jpurb0 of session 0mfymklhce1yj3gp belongs to a previously existing user
[INFO] 2020-01-21 13:30:50,686 [v4hvrs-e1018-t0] io.openvidu.server.core.Session (join) - SESSION 0mfymklhce1yj3gp: Added participant [participantPrivateId=esm0csv8fcnhjpf717fav4hvrs, participantPublicId=xsnldjrrb6jpurb0, streaming=false]
[INFO] 2020-01-21 13:30:50,701 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘publish’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,764 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (publishToRoom) - PARTICIPANT xsnldjrrb6jpurb0: Request to publish video in room 0mfymklhce1yj3gp (sdp type OFFER)
[INFO] 2020-01-21 13:30:50,809 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (publishToRoom) - PARTICIPANT xsnldjrrb6jpurb0: Is now publishing video in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,811 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,811 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,811 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,812 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,812 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,812 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,816 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘signal’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,820 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘signal’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,825 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: GATHERING | componentId: 1 | streamId: 1 | timestamp: 1579613450820
[INFO] 2020-01-21 13:30:50,825 [tExec-e988-t136] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: GATHERING | componentId: 2 | streamId: 1 | timestamp: 1579613450820
[INFO] 2020-01-21 13:30:50,841 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘subscribe’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,841 [i5u7rn-e1016-t0] io.openvidu.server.kurento.core.KurentoParticipant (receiveMediaFrom) - PARTICIPANT gfq3fnm59dhxaduq: Request to receive media from xsnldjrrb6jpurb0 in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,842 [tExec-e988-t136] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1579613450825
[INFO] 2020-01-21 13:30:50,908 [i5u7rn-e1016-t0] io.openvidu.server.kurento.core.KurentoParticipant (receiveMediaFrom) - PARTICIPANT gfq3fnm59dhxaduq: Is now receiving video from xsnldjrrb6jpurb0 in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,908 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,908 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,909 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,909 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,926 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$4) - KMS event [NewCandidatePairSelected]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | local: candidate:7 1 UDP 1677722111 84.88.36.225 29801 typ srflx raddr 192.168.114.233 rport 29801 | remote: candidate:436677988 1 UDP 1686052607 147.83.206.88 58540 typ srflx raddr 192.168.10.163 rport 58540 | timestamp: 1579613450915
[INFO] 2020-01-21 13:30:50,926 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1579613450915
[INFO] 2020-01-21 13:30:50,930 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: GATHERING | componentId: 1 | streamId: 1 | timestamp: 1579613450918
[INFO] 2020-01-21 13:30:50,931 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: GATHERING | componentId: 2 | streamId: 1 | timestamp: 1579613450918
[INFO] 2020-01-21 13:30:50,956 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:30:50,958 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1579613450921
[INFO] 2020-01-21 13:30:51,006 [tExec-e988-t158] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1579613451005
[INFO] 2020-01-21 13:30:51,006 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$4) - KMS event [NewCandidatePairSelected]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | local: candidate:7 1 UDP 1677722111 84.88.36.225 36986 typ srflx raddr 192.168.114.233 rport 36986 | remote: candidate:436677988 1 UDP 1686052607 147.83.206.88 49653 typ srflx raddr 192.168.10.163 rport 49653 | timestamp: 1579613451005
[INFO] 2020-01-21 13:30:51,788 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$3) - KMS event [ConnectionStateChanged]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1579613451787
[INFO] 2020-01-21 13:30:51,827 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$1) - KMS event [MediaFlowOutStateChange] -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: FLOWING | pad: default | mediaType: AUDIO | timestamp: 1579613451826
[INFO] 2020-01-21 13:30:51,828 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$5) - KMS event [MediaTranscodingStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: NOT_TRANSCODING | mediaType: AUDIO | binName: kmsagnosticbin2-53 | timestamp: 1579613451827
[INFO] 2020-01-21 13:30:51,916 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$3) - KMS event [ConnectionStateChanged]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1579613451915
[INFO] 2020-01-21 13:30:51,933 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$0) - KMS event [MediaFlowInStateChange] -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: FLOWING | pad: default | mediaType: AUDIO | timestamp: 1579613451933
[INFO] 2020-01-21 13:30:52,060 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$1) - KMS event [MediaFlowOutStateChange] -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: FLOWING | pad: default | mediaType: VIDEO | timestamp: 1579613452059
[INFO] 2020-01-21 13:30:52,121 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$5) - KMS event [MediaTranscodingStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: NOT_TRANSCODING | mediaType: VIDEO | binName: kmsagnosticbin2-52 | timestamp: 1579613452120
[INFO] 2020-01-21 13:30:52,237 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$0) - KMS event [MediaFlowInStateChange] -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: FLOWING | pad: default | mediaType: VIDEO | timestamp: 1579613452236
[INFO] 2020-01-21 13:30:58,790 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1579613458789
[INFO] 2020-01-21 13:30:58,888 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1579613458887
[INFO] 2020-01-21 13:31:06,617 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1579613466616
[INFO] 2020-01-21 13:31:06,618 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$2) - KMS event [IceGatheringDone] -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | timestamp: 1579613466618
[INFO] 2020-01-21 13:31:06,715 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$2) - KMS event [IceGatheringDone] -> endpoint: gfq3fnm59dhxaduq_xsnldjrrb6jpurb0_SCREEN_NMSII (subscriber) | timestamp: 1579613466714
[INFO] 2020-01-21 13:31:08,153 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: xsnldjrrb6jpurb0_SCREEN_NMSII (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1579613468152
[INFO] 2020-01-21 13:31:08,437 [v4hvrs-e1018-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant xsnldjrrb6jpurb0 is calling method ‘unpublish’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:08,437 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (unpublishMedia) - PARTICIPANT xsnldjrrb6jpurb0: unpublishing media stream from room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:08,438 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (unpublishMedia) - PARTICIPANT xsnldjrrb6jpurb0: released publisher endpoint and left it initialized (ready for future streaming)
[INFO] 2020-01-21 13:31:08,438 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (cancelReceivingMedia) - PARTICIPANT gfq3fnm59dhxaduq: cancel receiving media from xsnldjrrb6jpurb0
[INFO] 2020-01-21 13:31:08,439 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (cancelReceivingMedia) - PARTICIPANT gfq3fnm59dhxaduq: stopped receiving media from xsnldjrrb6jpurb0 in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:08,440 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (cancelReceivingMedia) - PARTICIPANT qqcsyfvjjy6gduh2: cancel receiving media from xsnldjrrb6jpurb0
[WARN] 2020-01-21 13:31:08,440 [v4hvrs-e1018-t0] io.openvidu.server.kurento.core.KurentoParticipant (cancelReceivingMedia) - PARTICIPANT qqcsyfvjjy6gduh2: Trying to cancel receiving video from user xsnldjrrb6jpurb0. But there is no such subscriber endpoint.
[INFO] 2020-01-21 13:31:08,449 [nfasuk-e1014-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant qqcsyfvjjy6gduh2 is calling method ‘signal’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,029 [0.0-4443-exec-5] io.openvidu.server.rest.SessionRestController (newToken) - REST API: POST /api/tokens {session=0mfymklhce1yj3gp, role=MODERATOR, data=, kurentoOptions={}}
[INFO] 2020-01-21 13:31:15,030 [0.0-4443-exec-5] io.openvidu.server.coturn.CoturnCredentialsService (createUser) - Creating COTURN user
[INFO] 2020-01-21 13:31:15,075 [0.0-4443-exec-5] io.openvidu.server.coturn.CoturnCredentialsService (createUser) - COTURN user created: true
[INFO] 2020-01-21 13:31:15,077 [0.0-4443-exec-5] io.openvidu.server.core.SessionManager (showTokens) - <SESSIONID, TOKENS>: {0mfymklhce1yj3gp={wss://hsjdvc.i2cat.net:4443?sessionId=0mfymklhce1yj3gp&token=vjetrwlgiuhlbrcp&role=MODERATOR&version=2.11.0&turnUsername=Q01J1X&turnCredential=krv77r=MODERATOR}, jotlkdqqdv9ldfze={}, fpipziyhreulrsa9={}, nrh7pzntwnbs2qqj={}, 0wczbtkeeqjx1blk={}, whms3pooswx1s2sy={wss://hsjdvc.i2cat.net:4443?sessionId=whms3pooswx1s2sy&token=hytmv10icsegdr6p&role=MODERATOR&version=2.11.0&turnUsername=7PODD7&turnCredential=gxhhma=MODERATOR}, eijwbor41wnrd3xl={}, r6am7hwkmf5tbohc={}, zce8xmzyk26axvea={}, sjd86hwtfniuo1ui={wss://hsjdvc.i2cat.net:4443?sessionId=sjd86hwtfniuo1ui&token=m9o7ukumydq8h7qu&role=SUBSCRIBER&version=2.11.0&turnUsername=TIRTOB&turnCredential=kv9jx2=SUBSCRIBER, wss://hsjdvc.i2cat.net:4443?sessionId=sjd86hwtfniuo1ui&token=fpnl6squqdqqul1e&role=MODERATOR&version=2.11.0&turnUsername=YTXHAQ&turnCredential=h62lz5=MODERATOR}}
[INFO] 2020-01-21 13:31:15,137 [0.0-4443-exec-7] io.openvidu.server.config.HttpHandshakeInterceptor (beforeHandshake) - Old HttpSession F6CE7DCC4C8A64727F6D47AD1C84BD67
[INFO] 2020-01-21 13:31:15,164 [0.0-4443-exec-6] io.openvidu.server.rpc.RpcHandler (afterConnectionEstablished) - After connection established for WebSocket session: nkn8ruse8k3hqsu5q7ur4fhbud
[INFO] 2020-01-21 13:31:15,165 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (joinRoom) - Final user reconnecting
[INFO] 2020-01-21 13:31:15,165 [4fhbud-e1020-t0] io.openvidu.server.core.SessionManager (newParticipant) - Participant ha2zvuxwmc8wuwb4 of session 0mfymklhce1yj3gp belongs to a previously existing user
[INFO] 2020-01-21 13:31:15,167 [4fhbud-e1020-t0] io.openvidu.server.core.Session (join) - SESSION 0mfymklhce1yj3gp: Added participant [participantPrivateId=nkn8ruse8k3hqsu5q7ur4fhbud, participantPublicId=ha2zvuxwmc8wuwb4, streaming=false]
[INFO] 2020-01-21 13:31:15,186 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘publish’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,203 [4fhbud-e1020-t0] io.openvidu.server.kurento.core.KurentoParticipant (publishToRoom) - PARTICIPANT ha2zvuxwmc8wuwb4: Request to publish video in room 0mfymklhce1yj3gp (sdp type OFFER)
[INFO] 2020-01-21 13:31:15,245 [4fhbud-e1020-t0] io.openvidu.server.kurento.core.KurentoParticipant (publishToRoom) - PARTICIPANT ha2zvuxwmc8wuwb4: Is now publishing video in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,247 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,248 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,248 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,248 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,251 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘signal’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,253 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘signal’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,264 [tExec-e988-t152] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: ha2zvuxwmc8wuwb4_SCREEN_XATSN (publisher) | state: GATHERING | componentId: 1 | streamId: 1 | timestamp: 1579613475257
[INFO] 2020-01-21 13:31:15,264 [tExec-e988-t152] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: ha2zvuxwmc8wuwb4_SCREEN_XATSN (publisher) | state: GATHERING | componentId: 2 | streamId: 1 | timestamp: 1579613475257
[INFO] 2020-01-21 13:31:15,272 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘subscribe’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,272 [i5u7rn-e1016-t0] io.openvidu.server.kurento.core.KurentoParticipant (receiveMediaFrom) - PARTICIPANT gfq3fnm59dhxaduq: Request to receive media from ha2zvuxwmc8wuwb4 in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,274 [tExec-e988-t147] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: ha2zvuxwmc8wuwb4_SCREEN_XATSN (publisher) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1579613475259
[INFO] 2020-01-21 13:31:15,303 [4fhbud-e1020-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant ha2zvuxwmc8wuwb4 is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,412 [i5u7rn-e1016-t0] io.openvidu.server.kurento.core.KurentoParticipant (receiveMediaFrom) - PARTICIPANT gfq3fnm59dhxaduq: Is now receiving video from ha2zvuxwmc8wuwb4 in room 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,412 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,413 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,413 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,414 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,414 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,414 [i5u7rn-e1016-t0] io.openvidu.server.rpc.RpcHandler (sanityCheckOfSession) - Participant gfq3fnm59dhxaduq is calling method ‘onIceCandidate’ in session 0mfymklhce1yj3gp
[INFO] 2020-01-21 13:31:15,421 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: GATHERING | componentId: 1 | streamId: 1 | timestamp: 1579613475417
[INFO] 2020-01-21 13:31:15,461 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: GATHERING | componentId: 2 | streamId: 1 | timestamp: 1579613475417
[INFO] 2020-01-21 13:31:15,465 [tExec-e988-t152] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1579613475422
[INFO] 2020-01-21 13:31:15,487 [tExec-e988-t152] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$4) - KMS event [NewCandidatePairSelected]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | local: candidate:7 1 UDP 1677722111 84.88.36.225 14578 typ srflx raddr 192.168.114.233 rport 14578 | remote: candidate:436677988 1 UDP 1686052607 147.83.206.88 51972 typ srflx raddr 192.168.10.163 rport 51972 | timestamp: 1579613475486
[INFO] 2020-01-21 13:31:15,488 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1579613475486
[INFO] 2020-01-21 13:31:16,418 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$3) - KMS event [ConnectionStateChanged]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1579613476417
[INFO] 2020-01-21 13:31:23,382 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1579613483381
[INFO] 2020-01-21 13:31:31,064 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$2) - KMS event [IceGatheringDone] -> endpoint: ha2zvuxwmc8wuwb4_SCREEN_XATSN (publisher) | timestamp: 1579613491063
[INFO] 2020-01-21 13:31:31,227 [tExec-e988-t152] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$2) - KMS event [IceGatheringDone] -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | timestamp: 1579613491226
[INFO] 2020-01-21 13:31:31,227 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1579613491226
[INFO] 2020-01-21 13:31:32,728 [tExec-e988-t151] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig (lambda$addEndpointListeners$6) - KMS event [IceComponentStateChange]: -> endpoint: gfq3fnm59dhxaduq_ha2zvuxwmc8wuwb4_SCREEN_XATSN (subscriber) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1579613492727

Really thanks for your help!!