I implement the react native application as in the example, when the “streamCreated” event arrives, I call session.subscribe (event.stream) and various errors periodically occur in it: Request has timed out in Request “onIceCandidate”, ERROR: Can`t add existing ICE candidates to null (Code 403 in Request)
Some error on servers versions 2.12.0 and 2.13.0, RN library version 2.11.0
Please can you share with us openvidu server logs? It seems a problem with the server.
I can`t attach file =( Log is to large…
[INFO] 2020-04-28 12:27:23,386 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,387 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,395 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘subscribe’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,396 [msg9uv4-e120-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: Request to receive media from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:23,397 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘subscribe’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,397 [ucfvf2h-e122-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: Request to receive media from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:23,437 [entExec-e2-t568] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1588066043402
[INFO] 2020-04-28 12:27:23,439 [entExec-e2-t570] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceGatheringDone] -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | timestamp: 1588066043398
[INFO] 2020-04-28 12:27:23,486 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,516 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,521 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,533 [msg9uv4-e120-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: Is now receiving video from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:23,535 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,538 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,539 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,539 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,540 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,540 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,543 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,547 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,549 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,550 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,551 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,552 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,555 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,557 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,558 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,560 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,562 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,565 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,619 [entExec-e2-t575] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceGatheringDone] -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | timestamp: 1588066043567
[INFO] 2020-04-28 12:27:23,626 [entExec-e2-t577] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1588066043577
[INFO] 2020-04-28 12:27:23,696 [ucfvf2h-e122-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: Is now receiving video from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:23,697 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,697 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,698 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,699 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,699 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,700 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,700 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,702 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,707 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,712 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,714 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,717 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,720 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,721 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,726 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,728 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,731 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,732 [ucfvf2h-e122-t0] io.openvidu.server.rpc.RpcHandler - Participant con_E7YejzU5NZ is calling method ‘onIceCandidate’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:23,789 [entExec-e2-t573] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceGatheringDone] -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | timestamp: 1588066043737
[INFO] 2020-04-28 12:27:23,790 [entExec-e2-t572] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: CONNECTING | componentId: 1 | streamId: 1 | timestamp: 1588066043741
[INFO] 2020-04-28 12:27:23,968 [entExec-e2-t582] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [NewCandidatePairSelected]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | local: candidate:7 1 UDP 2013266429 89.223.24.145 56031 typ host | remote: cand
idate:3589960279 1 UDP 41754623 89.223.24.145 46117 typ relay raddr 95.73.38.152 rport 52205 | timestamp: 1588066043967
[INFO] 2020-04-28 12:27:23,969 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1588066043967
[INFO] 2020-04-28 12:27:24,028 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [NewCandidatePairSelected]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | local: candidate:7 1 UDP 2013266429 89.223.24.145 30967 typ host | remote: candidate:3127819443
1 UDP 1686052607 95.73.38.152 64164 typ srflx raddr 192.168.1.38 rport 64164 | timestamp: 1588066044025
[INFO] 2020-04-28 12:27:24,029 [entExec-e2-t582] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1588066044025
[INFO] 2020-04-28 12:27:24,051 [entExec-e2-t582] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [NewCandidatePairSelected]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | local: candidate:7 1 UDP 2013266429 89.223.24.145 22197 typ host | remote: cand
idate:3589960279 1 UDP 41754623 89.223.24.145 59539 typ relay raddr 95.73.38.152 rport 52211 | timestamp: 1588066044050
[INFO] 2020-04-28 12:27:24,051 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1588066044050
[INFO] 2020-04-28 12:27:24,133 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [NewCandidatePairSelected]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | local: candidate:7 1 UDP 2013266429 89.223.24.145 56031 typ host | remote: cand
idate:2968651718 1 UDP 1685921535 95.73.38.152 52205 typ srflx raddr 192.168.1.49 rport 52205 | timestamp: 1588066044131
[INFO] 2020-04-28 12:27:24,312 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [NewCandidatePairSelected]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | local: candidate:7 1 UDP 2013266429 89.223.24.145 22197 typ host | remote: cand
idate:2968651718 1 UDP 1685921535 95.73.38.152 52211 typ srflx raddr 192.168.1.49 rport 52211 | timestamp: 1588066044310
[INFO] 2020-04-28 12:27:24,381 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [ConnectionStateChanged]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066044379
[INFO] 2020-04-28 12:27:24,533 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaFlowOutStateChange] -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | state: FLOWING | pad: default | mediaType: AUDIO | timestamp: 1588066044531
[INFO] 2020-04-28 12:27:24,544 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [ConnectionStateChanged]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066044542
[INFO] 2020-04-28 12:27:24,545 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaTranscodingStateChange]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | state: NOT_TRANSCODING | mediaType: AUDIO | binName: kmsagnosticbin2-1688 | timestamp: 15880
66044534
[INFO] 2020-04-28 12:27:24,566 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaFlowInStateChange] -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: FLOWING | pad: default | mediaType: AUDIO | timestamp: 1588066044565
[INFO] 2020-04-28 12:27:24,700 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [ConnectionStateChanged]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066044699
[INFO] 2020-04-28 12:27:24,714 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaFlowInStateChange] -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: FLOWING | pad: default | mediaType: AUDIO | timestamp: 1588066044713
[INFO] 2020-04-28 12:27:24,949 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaStateChangedEvent]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066044946
[INFO] 2020-04-28 12:27:26,047 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaStateChangedEvent]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066046045
[INFO] 2020-04-28 12:27:26,207 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaStateChangedEvent]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | oldState: DISCONNECTED | newState: CONNECTED | timestamp: 1588066046205
[INFO] 2020-04-28 12:27:31,421 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: str_CAM_Pqil_con_DcO6FrvuUw (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1588066051420
[INFO] 2020-04-28 12:27:35,047 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_E7YejzU5NZ_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1588066055046
[INFO] 2020-04-28 12:27:38,114 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: -> endpoint: con_KwjnZz5ob2_str_CAM_Pqil_con_DcO6FrvuUw (subscriber) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1588066058112
[INFO] 2020-04-28 12:27:39,580 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw is calling method ‘disconnect’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:39,581 [nm9afmc-e124-t0] io.openvidu.server.core.Session - PARTICIPANT con_DcO6FrvuUw: Leaving session 516101-Topic-2
[INFO] 2020-04-28 12:27:39,581 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: cancel receiving media from con_DcO6FrvuUw
[INFO] 2020-04-28 12:27:39,582 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: stopped receiving media from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:39,589 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: cancel receiving media from con_DcO6FrvuUw
[INFO] 2020-04-28 12:27:39,589 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: stopped receiving media from con_DcO6FrvuUw in room 516101-Topic-2
[WARN] 2020-04-28 12:27:39,592 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_DcO6FrvuUw: Trying to close subscriber endpoint to con_E7YejzU5NZ. But the endpoint was never instantiated.
[WARN] 2020-04-28 12:27:39,593 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_DcO6FrvuUw: Trying to close subscriber endpoint to con_KwjnZz5ob2. But the endpoint was never instantiated.
[INFO] 2020-04-28 12:27:39,594 [nm9afmc-e124-t0] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2020-04-28 12:27:39,674 [nm9afmc-e124-t0] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[INFO] 2020-04-28 12:27:39,677 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcNotificationService - Closed session for participant with private id ic1530slh2t4ko8rj0bnm9afmc
[INFO] 2020-04-28 12:27:39,677 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcNotificationService - <PRIVATE_ID, RPC_CONNECTION>: {5k1fqgsdmpa3bso43s2ucfvf2h=io.openvidu.server.rpc.RpcConnection@bd417fa, e3j5hflp7qmcn7gmamvmsg9uv4=io.openvidu.server.rpc.RpcConnection@5c49450b}
[INFO] 2020-04-28 12:27:39,678 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw has left session 516101-Topic-2
[INFO] 2020-04-28 12:27:49,677 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: ic1530slh2t4ko8rj0bnm9afmc - Status: null
[INFO] 2020-04-28 12:28:12,342 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘disconnect’ in session 516101-Topic-2
[INFO] 2020-04-28 12:27:39,581 [nm9afmc-e124-t0] io.openvidu.server.core.Session - PARTICIPANT con_DcO6FrvuUw: Leaving session 516101-Topic-2
[INFO] 2020-04-28 12:27:39,581 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: cancel receiving media from con_DcO6FrvuUw
[INFO] 2020-04-28 12:27:39,582 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: stopped receiving media from con_DcO6FrvuUw in room 516101-Topic-2
[INFO] 2020-04-28 12:27:39,589 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: cancel receiving media from con_DcO6FrvuUw
[INFO] 2020-04-28 12:27:39,589 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_KwjnZz5ob2: stopped receiving media from con_DcO6FrvuUw in room 516101-Topic-2
[WARN] 2020-04-28 12:27:39,592 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_DcO6FrvuUw: Trying to close subscriber endpoint to con_E7YejzU5NZ. But the endpoint was never instantiated.
[WARN] 2020-04-28 12:27:39,593 [nm9afmc-e124-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_DcO6FrvuUw: Trying to close subscriber endpoint to con_KwjnZz5ob2. But the endpoint was never instantiated.
[INFO] 2020-04-28 12:27:39,594 [nm9afmc-e124-t0] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2020-04-28 12:27:39,674 [nm9afmc-e124-t0] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[INFO] 2020-04-28 12:27:39,677 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcNotificationService - Closed session for participant with private id ic1530slh2t4ko8rj0bnm9afmc
[INFO] 2020-04-28 12:27:39,677 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcNotificationService - <PRIVATE_ID, RPC_CONNECTION>: {5k1fqgsdmpa3bso43s2ucfvf2h=io.openvidu.server.rpc.RpcConnection@bd417fa, e3j5hflp7qmcn7gmamvmsg9uv4=io.openvidu.server.rpc.RpcConnection@5c49450b}
[INFO] 2020-04-28 12:27:39,678 [nm9afmc-e124-t0] io.openvidu.server.rpc.RpcHandler - Participant con_DcO6FrvuUw has left session 516101-Topic-2
[INFO] 2020-04-28 12:27:49,677 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: ic1530slh2t4ko8rj0bnm9afmc - Status: null
[INFO] 2020-04-28 12:28:12,342 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 is calling method ‘disconnect’ in session 516101-Topic-2
[INFO] 2020-04-28 12:28:12,344 [msg9uv4-e120-t0] io.openvidu.server.core.Session - PARTICIPANT con_KwjnZz5ob2: Leaving session 516101-Topic-2
[INFO] 2020-04-28 12:28:12,344 [msg9uv4-e120-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: cancel receiving media from con_KwjnZz5ob2
[INFO] 2020-04-28 12:28:12,345 [msg9uv4-e120-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_E7YejzU5NZ: stopped receiving media from con_KwjnZz5ob2 in room 516101-Topic-2
[INFO] 2020-04-28 12:28:12,376 [msg9uv4-e120-t0] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2020-04-28 12:28:12,466 [msg9uv4-e120-t0] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[ERROR] 2020-04-28 12:28:12,467 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcNotificationService - Exception sending notification ‘participantLeft’: {“connectionId”:“con_KwjnZz5ob2”,“reason”:“disconnect”} to participant with private id 5k1fqgsdmpa3bso43s2ucfvf2h
org.kurento.commons.exception.KurentoException: Exception while sending message ‘{“method”:“participantLeft”,“params”:{“connectionId”:“con_KwjnZz5ob2”,“reason”:“disconnect”},“jsonrpc”:“2.0”}’ to websocket with native sessionId ‘451a00a4-45da-baf1-1ff9-9642f95289c7’
at org.kurento.jsonrpc.internal.ws.WebSocketServerSession.sendRequestWebSocket(WebSocketServerSession.java:123)
at org.kurento.jsonrpc.internal.ws.WebSocketServerSession.access$000(WebSocketServerSession.java:49)
at org.kurento.jsonrpc.internal.ws.WebSocketServerSession$1.internalSendRequest(WebSocketServerSession.java:74)
at org.kurento.jsonrpc.internal.JsonRpcRequestSenderHelper.sendRequest(JsonRpcRequestSenderHelper.java:75)
at org.kurento.jsonrpc.internal.JsonRpcRequestSenderHelper.sendNotification(JsonRpcRequestSenderHelper.java:156)
at org.kurento.jsonrpc.internal.server.ServerSession.sendNotification(ServerSession.java:121)
at io.openvidu.server.rpc.RpcNotificationService.sendNotification(RpcNotificationService.java:105)
at io.openvidu.server.core.SessionEventsHandler.onParticipantLeft(SessionEventsHandler.java:181)
at io.openvidu.server.kurento.core.KurentoSessionManager.leaveRoom(KurentoSessionManager.java:195)
at io.openvidu.server.rpc.RpcHandler.leaveRoom(RpcHandler.java:308)
at io.openvidu.server.rpc.RpcHandler.handleRequest(RpcHandler.java:121)
at org.kurento.jsonrpc.internal.JsonRpcHandlerManager.handleRequest(JsonRpcHandlerManager.java:142)
at org.kurento.jsonrpc.internal.server.ProtocolManager$3.run(ProtocolManager.java:218)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.IllegalStateException: The WebSocket session [40] has been closed and no method (apart from close()) may be called on a closed session
at org.apache.tomcat.websocket.WsSession.checkState(WsSession.java:836)
at org.apache.tomcat.websocket.WsSession.getBasicRemote(WsSession.java:433)
at org.springframework.web.socket.adapter.standard.StandardWebSocketSession.sendTextMessage(StandardWebSocketSession.java:215)
at org.springframework.web.socket.adapter.AbstractWebSocketSession.sendMessage(AbstractWebSocketSession.java:106)
at org.kurento.jsonrpc.internal.ws.WebSocketServerSession.sendRequestWebSocket(WebSocketServerSession.java:119)
… 15 common frames omitted
[ERROR] 2020-04-28 12:28:12,470 [msg9uv4-e120-t0] org.kurento.jsonrpc.internal.ws.JsonRpcWebSocketHandler - Trying to send a message to a closed session
[INFO] 2020-04-28 12:28:12,470 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcNotificationService - Closed session for participant with private id e3j5hflp7qmcn7gmamvmsg9uv4
[INFO] 2020-04-28 12:28:12,470 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcNotificationService - <PRIVATE_ID, RPC_CONNECTION>: {5k1fqgsdmpa3bso43s2ucfvf2h=io.openvidu.server.rpc.RpcConnection@bd417fa}
[INFO] 2020-04-28 12:28:12,471 [msg9uv4-e120-t0] io.openvidu.server.rpc.RpcHandler - Participant con_KwjnZz5ob2 has left session 516101-Topic-2
[INFO] 2020-04-28 12:28:15,412 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaFlowOutStateChange] -> endpoint: str_CAM_ZWhj_con_E7YejzU5NZ (publisher) | state: NOT_FLOWING | pad: default | mediaType: VIDEO | timestamp: 1588066095411
[INFO] 2020-04-28 12:28:15,418 [entExec-e2-t581] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [MediaFlowOutStateChange] -> endpoint: str_CAM_ZWhj_con_E7YejzU5NZ (publisher) | state: NOT_FLOWING | pad: default | mediaType: AUDIO | timestamp: 1588066095417
[INFO] 2020-04-28 12:28:22,343 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: e3j5hflp7qmcn7gmamvmsg9uv4 - Status: null
[INFO] 2020-04-28 12:28:22,349 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: 5k1fqgsdmpa3bso43s2ucfvf2h - Status: null
[INFO] 2020-04-28 12:28:22,351 [TaskScheduler-1] io.openvidu.server.rpc.RpcNotificationService - Closed session for participant with private id 5k1fqgsdmpa3bso43s2ucfvf2h
[INFO] 2020-04-28 12:28:22,351 [TaskScheduler-1] io.openvidu.server.rpc.RpcNotificationService - <PRIVATE_ID, RPC_CONNECTION>: {}
[INFO] 2020-04-28 12:28:22,351 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - Evicting participant with private id 5k1fqgsdmpa3bso43s2ucfvf2h because its websocket unexpectedly closed in the client side
[INFO] 2020-04-28 12:28:22,351 [TaskScheduler-1] io.openvidu.server.core.Session - PARTICIPANT con_E7YejzU5NZ: Leaving session 516101-Topic-2
[INFO] 2020-04-28 12:28:22,364 [TaskScheduler-1] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2020-04-28 12:28:22,414 [TaskScheduler-1] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[INFO] 2020-04-28 12:28:22,416 [TaskScheduler-1] io.openvidu.server.kurento.core.KurentoSessionManager - No more participants in session ‘516101-Topic-2’, removing it and closing it
[INFO] 2020-04-28 12:28:22,417 [TaskScheduler-1] io.openvidu.server.core.SessionManager - Session ‘516101-Topic-2’ removed and closed
[ERROR] 2020-04-28 12:28:22,419 [TaskScheduler-1] io.openvidu.server.rpc.RpcNotificationService - No rpc session found for private id 5k1fqgsdmpa3bso43s2ucfvf2h, unable to send notification participantEvicted: {“connectionId”:“con_E7YejzU5NZ”,“reason”:“networkDisconnect”}
[ERROR] 2020-04-28 12:28:22,419 [TaskScheduler-1] io.openvidu.server.rpc.RpcNotificationService - No rpc session found for private id 5k1fqgsdmpa3bso43s2ucfvf2h, unable to send notification participantEvicted: {“connectionId”:“con_E7YejzU5NZ”,“reason”:“networkDisconnect”}
[ERROR] 2020-04-28 12:28:22,419 [TaskScheduler-1] io.openvidu.server.rpc.RpcNotificationService - No session found for private id 5k1fqgsdmpa3bso43s2ucfvf2h, unable to cleanup
[INFO] 2020-04-28 12:28:22,419 [TaskScheduler-1] io.openvidu.server.rpc.RpcHandler - Evicted participant with privateId 5k1fqgsdmpa3bso43s2ucfvf2h
This error does not occur every time, but very often
This error is reproduced in react-native version 0.59.10, in 0.61.5 everything is ok. Will there be some solution for 0.59.10? We can not upgrade to 0.61.5 ((
I’m sorry but we do not support old react-native versions.
Can you confirm that you don’t have any issue with version specified in the tutorial (0.61.5)?
Yes, with 0.61.5 works. We updated the project) It was not easy
