openVidu 2.20.0 - Recording is still in "starting" status

Hi, encountered this particular issue where subsequent attempts to do recording will result in the same error (java.lang.NullPointerException)

We use the same session id(f07376e0668a44a696c659178084b283) to start/stop recording

From the logs, the recording started but the user left and rejoined creating a new session, not sure if this contributes to the error.

Extracted logs below:

Initial session created:

[INFO] 2022-10-10 04:30:17,081 [http-nio-0.0.0.0-5443-exec-6] io.openvidu.server.rest.SessionRestController - REST API: POST /openvidu/api/sessions {mediaMode=ROUTED, recordingMode=MANUAL, customSessionId=f07376e0668a44a696c659178084b283, defaultRecordingProperties={name=, hasAudio=true, hasVideo=true, outputMode=INDIVIDUAL, ignoreFailedStreams=false}, forcedVideoCodec=VP8, allowTranscoding=false}
[INFO] 2022-10-10 04:30:17,082 [http-nio-0.0.0.0-5443-exec-6] io.openvidu.server.rest.SessionRestController - New session f07376e0668a44a696c659178084b283 created [INFO] 2022-10-10 04:30:17,084 [http-nio-0.0.0.0-5443-exec-1] io.openvidu.server.rest.SessionRestController - REST API: POST /openvidu/api/sessions/f07376e0668a44a696c659178084b283/connection {session=f07376e0668a44a696c659178084b283, type=WEBRTC, data={“serverData”: “applicant”}, record=null, role=PUBLISHER, kurentoOptions={allowedFilters=[GammaEmotionFilter]}, rtspUri=null, adaptativeBitrate=null, onlyPlayWithSubscribers=null, networkCache=null}
[INFO] 2022-10-10 04:30:17,084 [http-nio-0.0.0.0-5443-exec-1] io.openvidu.server.coturn.CoturnCredentialsService - Creating COTURN user
[INFO] 2022-10-10 04:30:17,103 [http-nio-0.0.0.0-5443-exec-1] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user created: true
[INFO] 2022-10-10 04:30:17,202 [http-nio-0.0.0.0-5443-exec-13] io.openvidu.server.config.HttpHandshakeInterceptor - New HttpSession 34BF1328FE7242CA1BF2BF650AACA8BD
[INFO] 2022-10-10 04:30:17,326 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.rpc.RpcHandler - After connection established for WebSocket session: upqt4hlnmp1shvi0t2a5501b6q
[INFO] 2022-10-10 04:30:17,327 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.core.SessionManager - Participant con_YNjSFxeYc6 of session f07376e0668a44a696c659178084b283 is a final user connecting to this session for the first time
[INFO] 2022-10-10 04:30:17,327 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - New Connection con_YNjSFxeYc6 in Session f07376e0668a44a696c659178084b283 with IP xx.xx.xx.xx and platform Safari 16.0 on OS X 10.15.7
[INFO] 2022-10-10 04:30:17,327 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSessionManager - KMS less loaded is ws://localhost:8888/kurento with a load of 1.0
[INFO] 2022-10-10 04:30:17,327 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSessionManager - No session ‘f07376e0668a44a696c659178084b283’ exists yet. Created one on KMS ‘media_TGuDvspD’ with ip ‘localhost’
[INFO] 2022-10-10 04:30:17,327 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSession - SESSION f07376e0668a44a696c659178084b283: Creating MediaPipeline
[INFO] 2022-10-10 04:30:17,345 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSession - SESSION f07376e0668a44a696c659178084b283: Added participant [participantPrivateId=upqt4hlnmp1shvi0t2a5501b6q, participantPublicId=con_YNjSFxeYc6, streaming=false]
[INFO] 2022-10-10 04:30:17,455 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘publish’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:17,455 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.utils.SDPMunging - [setCodecPreference] codec: VP8

Starting recording:

[INFO] 2022-10-10 04:30:19,738 [http-nio-0.0.0.0-5443-exec-13] io.openvidu.server.rest.SessionRestController - REST API: GET /openvidu/api/sessions
[INFO] 2022-10-10 04:30:19,762 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.rest.SessionRestController - REST API: POST /openvidu/api/recordings/start {name=, hasAudio=true, hasVideo=true, outputMode=INDIVIDUAL, ignoreFailedStreams=false, session=f07376e0668a44a696c659178084b283}
[INFO] 2022-10-10 04:30:19,762 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.recording.service.RecordingManager - Getting free recording id for session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:25,579 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:25,579 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_YNjSFxeYc6 was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:30:33,711 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:33,711 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_YNjSFxeYc6 was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:30:34,779 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29291] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_FtI3_con_YNjSFxeYc6 (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376234779
[INFO] 2022-10-10 04:30:41,663 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:41,663 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_YNjSFxeYc6 was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true

Leaving session

[INFO] 2022-10-10 04:30:41,663 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘unpublish’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:41,663 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_YNjSFxeYc6: unpublishing media stream from room f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoParticipant - Resetting publisher endpoint for participant con_YNjSFxeYc6
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_YNjSFxeYc6: released publisher endpoint and left it initialized (ready for future streaming)
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 is calling method ‘disconnect’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSessionManager - Request [LEAVE_ROOM] for participant con_YNjSFxeYc6 of session f07376e0668a44a696c659178084b283 with reason disconnect
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSession - PARTICIPANT con_YNjSFxeYc6: Leaving session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:41,664 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2022-10-10 04:30:41,677 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[INFO] 2022-10-10 04:30:41,677 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.kurento.core.KurentoSessionManager - No more participants in session ‘f07376e0668a44a696c659178084b283’, removing it and closing it
[INFO] 2022-10-10 04:30:41,678 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.core.SessionManager - Session ‘f07376e0668a44a696c659178084b283’ removed and closed
[INFO] 2022-10-10 04:30:41,678 [SessionHandler-upqt4hlnmp1shvi0t2a5501b6q-e3352-t0] io.openvidu.server.rpc.RpcHandler - Participant con_YNjSFxeYc6 has left session f07376e0668a44a696c659178084b283

Rejoin:

[INFO] 2022-10-10 04:30:50,461 [http-nio-0.0.0.0-5443-exec-9] io.openvidu.server.rest.SessionRestController - REST API: GET /openvidu/api/sessions
[INFO] 2022-10-10 04:30:50,471 [http-nio-0.0.0.0-5443-exec-8] io.openvidu.server.rest.SessionRestController - REST API: POST /openvidu/api/sessions {mediaMode=ROUTED, recordingMode=MANUAL, customSessionId=f07376e0668a44a696c659178084b283, defaultRecordingProperties={name=, hasAudio=true, hasVideo=true, outputMode=INDIVIDUAL, ignoreFailedStreams=false}, forcedVideoCodec=VP8, allowTranscoding=false}
[INFO] 2022-10-10 04:30:50,472 [http-nio-0.0.0.0-5443-exec-8] io.openvidu.server.rest.SessionRestController - New session f07376e0668a44a696c659178084b283 created [ge-676e77123cd344de8a87d02a6318ab74, ge-d4069df0f83f4cb0bc63b569d9113ec5, ge-1c8a4680a3ab4e2b86775c38d43a63da, ge-e8c3372f608f44419d483b3b151006d0, ge-457038323212453cbf8ce613fe08e904, ge-9728a4f7fb8848578ae16e119b67cae3, ge-32a2caf87cd24640ab0ee087525c7a8c, ge-1988442dede747beb5e3186a0f6d5924, ge-84309ed8b88f40d88e3619b82cdb7116, ge-fab9a7aa4f824fe6985228af01cbfbc0, ge-765b4a4315cb455fa651251baeca8c14, ge-00dd44dcdbbd42ceb1d6525d3815cbb3, ge-f226356e2f844a35bab06317d1f80ec8, ge-746be2b050e74419a54a2e176fba727d, ge-645203ded37d46e3aa38cbc0dc94e292, ge-e102e82744904fbf8c75dff1e30d1aa9, ge-e6decfd98d214b20990d22d53e6ce2cb, ge-3dc347b4b8e34a32b2ef71e5a1f1fafc, ge-4a06cbe97dcb4ef6ab7e47c52dead805, ge-b62fdb212a574db1929f95362a7f7965, ge-3eda5b93c648403aa7b40ffddbcdacaa, ge-479c2a09722d484f97077c34b22ab7b8, ge-9638ff4f0a1b4fc99791e1e8ef90c9ad, ge-67801eb2fb994f8fb09086c35cbf399e, ge-41073731e5264efbb72919f9c50a2941, ge-591fcf72e23c4c23b90fedb403791776, ge-c47c0402d36b4546aad59b2ad09e8576, ge-83a584a534634d14ba9392ced0638f1d, ge-97c7ab98fbe846018e776b4b10d7831a, ge-d9e20ee3c1db4384bc53893f953abce5, ge-a794a10e55254bdeacb06a2cb2167e6c, ge-23aab9a34bc546af90be890f83a7c8eb, ge-6587ecc931c8466488b0129753a834db, ge-c6651098be2f4928b94824db08627703, ge-677b3ae7a3ae4efda96ed9fab87dbef8, ge-ca7255b5f720471e99fa31fc990f395b, ge-d3512a7308314e8eb0a749ff4744c187, f07376e0668a44a696c659178084b283, ge-cfcab6090a9e4935806885e5e3a25b50, ge-d703e238a97846bda02de5012604376f, ge-fd63f6cf580445cbbe0498033eaf144c, ge-68cd2c9e6884424daeae7fb82904785e, ge-75b5e2cbb944410596178900538c5254]
[INFO] 2022-10-10 04:30:50,473 [http-nio-0.0.0.0-5443-exec-12] io.openvidu.server.rest.SessionRestController - REST API: POST /openvidu/api/sessions/f07376e0668a44a696c659178084b283/connection {session=f07376e0668a44a696c659178084b283, type=WEBRTC, data={“serverData”: “applicant”}, record=null, role=PUBLISHER, kurentoOptions={allowedFilters=[GammaEmotionFilter]}, rtspUri=null, adaptativeBitrate=null, onlyPlayWithSubscribers=null, networkCache=null}
[INFO] 2022-10-10 04:30:50,473 [http-nio-0.0.0.0-5443-exec-12] io.openvidu.server.coturn.CoturnCredentialsService - Creating COTURN user
[INFO] 2022-10-10 04:30:50,488 [http-nio-0.0.0.0-5443-exec-12] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user created: true
[INFO] 2022-10-10 04:30:50,554 [http-nio-0.0.0.0-5443-exec-6] io.openvidu.server.config.HttpHandshakeInterceptor - Old HttpSession 34BF1328FE7242CA1BF2BF650AACA8BD
[INFO] 2022-10-10 04:30:50,715 [http-nio-0.0.0.0-5443-exec-1] io.openvidu.server.rpc.RpcHandler - After connection established for WebSocket session: 44f5c4gtg884avl0fhgfg8f4h4
[INFO] 2022-10-10 04:30:50,716 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.core.SessionManager - Participant con_FfQcLBmjGU of session f07376e0668a44a696c659178084b283 is a final user connecting to this session for the first time
[INFO] 2022-10-10 04:30:50,716 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - New Connection con_FfQcLBmjGU in Session f07376e0668a44a696c659178084b283 with IP xx.xx.xx.xx and platform Safari 16.0 on OS X 10.15.7
[INFO] 2022-10-10 04:30:50,716 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSessionManager - KMS less loaded is ws://localhost:8888/kurento with a load of 1.0
[INFO] 2022-10-10 04:30:50,716 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSessionManager - No session ‘f07376e0668a44a696c659178084b283’ exists yet. Created one on KMS ‘media_TGuDvspD’ with ip ‘localhost’
[INFO] 2022-10-10 04:30:50,716 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSession - SESSION f07376e0668a44a696c659178084b283: Creating MediaPipeline
[INFO] 2022-10-10 04:30:50,726 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSession - SESSION f07376e0668a44a696c659178084b283: Added participant [participantPrivateId=44f5c4gtg884avl0fhgfg8f4h4, participantPublicId=con_FfQcLBmjGU, streaming=false]
[INFO] 2022-10-10 04:30:50,782 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘publish’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:50,782 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.utils.SDPMunging - [setCodecPreference] codec: VP8

Attempt to record after second session is created, and error hit:

[INFO] 2022-10-10 04:30:53,398 [http-nio-0.0.0.0-5443-exec-3] io.openvidu.server.recording.service.RecordingManager - Getting free recording id for session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:53,437 [jsonrpcTaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: upqt4hlnmp1shvi0t2a5501b6q - Status: null
[INFO] 2022-10-10 04:30:53,967 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376253966
[INFO] 2022-10-10 04:30:55,540 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1665376255539
[INFO] 2022-10-10 04:30:56,183 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.recording.service.RecordingManager - Free recording id got for session f07376e0668a44a696c659178084b283: f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:56,183 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.recording.service.RecordingService - New recording id (f07376e0668a44a696c659178084b283) and final name (f07376e0668a44a696c659178084b283)
[INFO] 2022-10-10 04:30:56,183 [http-nio-0.0.0.0-5443-exec-11] io.openvidu.server.recording.service.SingleStreamRecordingService - Starting individual (video+audio) recording f07376e0668a44a696c659178084b283 of session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:57,573 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376257572
[INFO] 2022-10-10 04:30:59,093 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:59,093 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_FfQcLBmjGU was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:30:59,094 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1665376259094
[INFO] 2022-10-10 04:30:59,172 [http-nio-0.0.0.0-5443-exec-3] io.openvidu.server.recording.service.RecordingManager - Free recording id got for session f07376e0668a44a696c659178084b283: f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:30:59,172 [http-nio-0.0.0.0-5443-exec-3] io.openvidu.server.recording.service.RecordingService - New recording id (f07376e0668a44a696c659178084b283) and final name (f07376e0668a44a696c659178084b283)
[INFO] 2022-10-10 04:31:01,113 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376261112
[INFO] 2022-10-10 04:31:02,050 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1665376262050
[INFO] 2022-10-10 04:31:04,072 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376264072
[INFO] 2022-10-10 04:31:04,763 [http-nio-0.0.0.0-5443-exec-7] io.openvidu.server.rest.SessionRestController - REST API: GET /openvidu/api/sessions
[INFO] 2022-10-10 04:31:05,070 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: CONNECTED | componentId: 1 | streamId: 1 | timestamp: 1665376265070
[INFO] 2022-10-10 04:31:06,944 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:31:06,944 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_FfQcLBmjGU was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:31:07,093 [AbstractJsonRpcClientWebSocket-reqResEventExec-e2-t29285] io.openvidu.server.kurento.core.KurentoParticipantEndpointConfig - KMS event [IceComponentStateChange]: → endpoint: str_CAM_OdGy_con_FfQcLBmjGU (publisher) | state: READY | componentId: 1 | streamId: 1 | timestamp: 1665376267092
[INFO] 2022-10-10 04:31:14,943 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:31:14,943 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_FfQcLBmjGU was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:31:22,943 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘videoData’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:31:22,943 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.core.SessionEventsHandler - Video data of participant con_FfQcLBmjGU was initialized. height:480, width:640, isVideoActive: true, isAudioActive: true
[INFO] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘unpublish’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_FfQcLBmjGU: unpublishing media stream from room f07376e0668a44a696c659178084b283
[WARN] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.recording.service.RecordingManager - Recording f07376e0668a44a696c659178084b283 is still in “starting” status
[INFO] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.recording.service.RecordingManager - Stopping RecorderEndpoint in session f07376e0668a44a696c659178084b283 for stream of participant str_CAM_OdGy_con_FfQcLBmjGU
[INFO] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.recording.service.SingleStreamRecordingService - Stopping single stream recorder for stream str_CAM_OdGy_con_FfQcLBmjGU in recording f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:32:23,234 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.recording.service.SingleStreamRecordingService - Stream str_CAM_OdGy_con_FfQcLBmjGU wasn’t being recorded in recording f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoParticipant - Resetting publisher endpoint for participant con_FfQcLBmjGU
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoParticipant - PARTICIPANT con_FfQcLBmjGU: released publisher endpoint and left it initialized (ready for future streaming)
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.rpc.RpcHandler - Participant con_FfQcLBmjGU is calling method ‘disconnect’ in session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSessionManager - Request [LEAVE_ROOM] for participant con_FfQcLBmjGU of session f07376e0668a44a696c659178084b283 with reason disconnect
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSession - PARTICIPANT con_FfQcLBmjGU: Leaving session f07376e0668a44a696c659178084b283
[INFO] 2022-10-10 04:32:23,235 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.coturn.CoturnCredentialsService - Deleting COTURN user
[INFO] 2022-10-10 04:32:23,247 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.coturn.CoturnCredentialsService - COTURN user deleted: true
[INFO] 2022-10-10 04:32:23,248 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] io.openvidu.server.kurento.core.KurentoSessionManager - Last participant left. Starting 10 seconds countdown for stopping recording of session f07376e0668a44a696c659178084b283
[ERROR] 2022-10-10 04:32:23,248 [SessionHandler-44f5c4gtg884avl0fhgfg8f4h4-e3354-t0] org.kurento.jsonrpc.internal.JsonRpcHandlerManager - Exception while processing request {“id”:65,“method”:“leaveRoom”,“params”:{},“jsonrpc”:“2.0”}
java.lang.NullPointerException: null
at io.openvidu.server.recording.service.RecordingManager.initAutomaticRecordingStopThread(RecordingManager.java:640)
at io.openvidu.server.kurento.core.KurentoSessionManager.leaveRoom(KurentoSessionManager.java:279)
at io.openvidu.server.rpc.RpcHandler.leaveRoom(RpcHandler.java:328)
at io.openvidu.server.rpc.RpcHandler.handleRequest(RpcHandler.java:122)
at org.kurento.jsonrpc.internal.JsonRpcHandlerManager.handleRequest(JsonRpcHandlerManager.java:142)
at org.kurento.jsonrpc.internal.server.ProtocolManager$3.run(ProtocolManager.java:218)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
[INFO] 2022-10-10 04:32:33,248 [pool-1-thread-3] io.openvidu.server.rpc.RpcNotificationService - Closed rpc session for participant with private id 44f5c4gtg884avl0fhgfg8f4h4
[INFO] 2022-10-10 04:32:33,248 [pool-1-thread-3] io.openvidu.server.rpc.RpcNotificationService - <PRIVATE_ID, RPC_CONNECTION>: {7d44f6lk8r7ddi9h890srfbun0=io.openvidu.server.rpc.RpcConnection@32c88eb1, ln9vntu31tahp8487j1p1ap6sd=io.openvidu.server.rpc.RpcConnection@3b8ceaf8, 1qcbhorgqbt2dd5eqd3rjhhasg=io.openvidu.server.rpc.RpcConnection@283b535, faef9g2p46b2og0nb98e4khqe2=io.openvidu.server.rpc.RpcConnection@78705e99, lvkrj3m223qk0vll7dmhibf2hr=io.openvidu.server.rpc.RpcConnection@3e83d6d6}
[INFO] 2022-10-10 04:32:34,674 [jsonrpcTaskScheduler-1] io.openvidu.server.rpc.RpcHandler - After connection closed for WebSocket session: 44f5c4gtg884avl0fhgfg8f4h4 - Status: null

Would appreciate some advice on how we can deal or recover from the above scenario?

Is there a way to invalidate the previous session where the user left abruptly and keep the same session id?

Many thanks