Hi all
Can you please someone with more experience can see this log and tell me if I’m using wong the API or maybe its a bug on openvidu ?
[INFO] 2020-02-03 10:36:38,538 [-5443-exec-1] io.openvidu.server.rest.SessionRestController (getSessionId) - REST API: POST /api/sessions {mediaMode=ROUTED, defaultOutputMode=COMPOSED, defaultCustomLayout=, customSessionId=, recordingMode=MANUAL, defaultRecordingLayout=BEST_FIT}
[INFO] 2020-02-03 10:36:41,041 [-5443-exec-6] io.openvidu.server.rest.SessionRestController (startRecordingSession) - REST API: POST /api/recordings/start {hasVideo=true, hasAudio=true, session=ouugkpwqrfotmt6x, name=, outputMode=INDIVIDUAL}
[INFO] 2020-02-03 10:36:41,042 [-5443-exec-6] io.openvidu.server.recording.service.RecordingService (setFinalRecordingNameAndGetFreeRecordingId) - New recording id (ouugkpwqrfotmt6x) and final name (ouugkpwqrfotmt6x)
[INFO] 2020-02-03 10:36:41,042 [-5443-exec-6] io.openvidu.server.recording.service.SingleStreamRecordingService (startRecording) - Starting individual (video+audio) recording ouugkpwqrfotmt6x of session ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:36:41,042 [-5443-exec-6] io.openvidu.server.recording.service.RecordingService (generateRecordingMetadataFile) - New folder /opt/openvidu/recordings/ouugkpwqrfotmt6x created. This means the recording started for a session with no publishers or no media type compatible publishers
[INFO] 2020-02-03 10:36:41,043 [-5443-exec-6] io.openvidu.server.recording.service.RecordingService (generateRecordingMetadataFile) - Generated recording metadata file at /opt/openvidu/recordings/ouugkpwqrfotmt6x/.recording.ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:36:41,043 [-5443-exec-6] io.openvidu.server.recording.service.RecordingManager (startRecording) - No publisher in session ouugkpwqrfotmt6x. Starting 120 seconds countdown for stopping recording
[INFO] 2020-02-03 10:36:43,216 [5m67-e507-t0] io.openvidu.server.recording.service.RecordingManager (startOneIndividualStreamRecording) - Starting new RecorderEndpoint in session ouugkpwqrfotmt6x for new stream of participant bcshbxxuv9ktrje4
[INFO] 2020-02-03 10:36:43,216 [5m67-e507-t0] io.openvidu.server.recording.service.SingleStreamRecordingService (startRecorderEndpointForPublisherEndpoint) - Starting single stream recorder for stream bcshbxxuv9ktrje4_CAMERA_QKIJH in session ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:36:43,269 [5m67-e507-t0] io.openvidu.server.kurento.core.KurentoSessionManager (publishVideo) - Participant bcshbxxuv9ktrje4 published before timeout finished. Aborting automatic recording stop
[INFO] 2020-02-03 10:36:43,269 [5m67-e507-t0] io.openvidu.server.kurento.core.KurentoSessionManager (publishVideo) - Automatic recording stopped succesfully aborted
[ERROR] 2020-02-03 10:36:43,271 [xec-e2-t6832] io.openvidu.server.recording.service.SingleStreamRecordingService (onEvent) - 6 Could not open file "/opt/openvidu/recordings/ouugkpwqrfotmt6x/bcshbxxuv9ktrje4_CAMERA_QKIJH.webm" for writing. (gstfilesink.c(438): gst_file_sink_open_file (): /GstPipeline:pipeline708/GstFileSink:filesink435:
[ERROR] 2020-02-03 10:36:43,273 [xec-e2-t6832] io.openvidu.server.recording.service.SingleStreamRecordingService (onEvent) - 4 GStreamer error: state change failed and some element failed to post a proper error message with the reason for the failure. (gstbasesink.c(5244): gst_base_sink_change_state (): /GstPipeline:pipeline708/GstFileSink:filesink435:
[WARN] 2020-02-03 10:36:43,274 [xec-e2-t6858] io.openvidu.server.core.Session (onEvent) - SESSION ouugkpwqrfotmt6x: Pipeline error encountered: UNEXPECTED_PIPELINE_ERROR: Could not open file "/opt/openvidu/recordings/ouugkpwqrfotmt6x/bcshbxxuv9ktrje4_CAMERA_QKIJH.webm" for writing. (gstfilesink.c(438): gst_file_sink_open_file (): /GstPipeline:pipeline708/GstFileSink:filesink435:
[INFO] 2020-02-03 10:36:54,726 [gu7j-e506-t0] io.openvidu.server.recording.service.RecordingManager (startOneIndividualStreamRecording) - Starting new RecorderEndpoint in session ouugkpwqrfotmt6x for new stream of participant luxal8bhjqo2ryku
[INFO] 2020-02-03 10:36:54,726 [gu7j-e506-t0] io.openvidu.server.recording.service.SingleStreamRecordingService (startRecorderEndpointForPublisherEndpoint) - Starting single stream recorder for stream luxal8bhjqo2ryku_CAMERA_FUBYJ in session ouugkpwqrfotmt6x
[WARN] 2020-02-03 10:36:54,755 [xec-e2-t6835] io.openvidu.server.core.Session (onEvent) - SESSION ouugkpwqrfotmt6x: Pipeline error encountered: UNEXPECTED_PIPELINE_ERROR: Could not open file "/opt/openvidu/recordings/ouugkpwqrfotmt6x/luxal8bhjqo2ryku_CAMERA_FUBYJ.webm" for writing. (gstfilesink.c(438): gst_file_sink_open_file (): /GstPipeline:pipeline709/GstFileSink:filesink436:
[ERROR] 2020-02-03 10:36:54,756 [xec-e2-t6835] io.openvidu.server.recording.service.SingleStreamRecordingService (onEvent) - 6 Could not open file "/opt/openvidu/recordings/ouugkpwqrfotmt6x/luxal8bhjqo2ryku_CAMERA_FUBYJ.webm" for writing. (gstfilesink.c(438): gst_file_sink_open_file (): /GstPipeline:pipeline709/GstFileSink:filesink436:
[ERROR] 2020-02-03 10:36:54,756 [xec-e2-t6856] io.openvidu.server.recording.service.SingleStreamRecordingService (onEvent) - 4 GStreamer error: state change failed and some element failed to post a proper error message with the reason for the failure. (gstbasesink.c(5244): gst_base_sink_change_state (): /GstPipeline:pipeline709/GstFileSink:filesink436:
[INFO] 2020-02-03 10:39:26,065 [gu7j-e506-t0] io.openvidu.server.recording.service.RecordingManager (stopOneIndividualStreamRecording) - Stopping RecorderEndpoint in session ouugkpwqrfotmt6x for stream of participant luxal8bhjqo2ryku_CAMERA_FUBYJ
[INFO] 2020-02-03 10:39:26,065 [gu7j-e506-t0] io.openvidu.server.recording.service.SingleStreamRecordingService (stopRecorderEndpointOfPublisherEndpoint) - Stopping single stream recorder for stream luxal8bhjqo2ryku_CAMERA_FUBYJ in session ouugkpwqrfotmt6x
[ERROR] 2020-02-03 10:39:31,068 [gu7j-e506-t0] io.openvidu.server.recording.service.RecordingManager (stopOneIndividualStreamRecording) - Error waiting for recorder endpoint of stream luxal8bhjqo2ryku_CAMERA_FUBYJ to stop in session ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:39:31,179 [5m67-e507-t0] io.openvidu.server.recording.service.RecordingManager (stopOneIndividualStreamRecording) - Stopping RecorderEndpoint in session ouugkpwqrfotmt6x for stream of participant bcshbxxuv9ktrje4_CAMERA_QKIJH
[INFO] 2020-02-03 10:39:31,179 [5m67-e507-t0] io.openvidu.server.recording.service.SingleStreamRecordingService (stopRecorderEndpointOfPublisherEndpoint) - Stopping single stream recorder for stream bcshbxxuv9ktrje4_CAMERA_QKIJH in session ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:39:31,691 [-5443-exec-5] io.openvidu.server.rest.SessionRestController (stopRecordingSession) - REST API: POST /api/recordings/stop/ouugkpwqrfotmt6x
[INFO] 2020-02-03 10:39:31,691 [-5443-exec-5] io.openvidu.server.recording.service.SingleStreamRecordingService (stopRecording) - Stopping individual (video+audio) recording ouugkpwqrfotmt6x of session ouugkpwqrfotmt6x. Reason: recordingStoppedByServer
[INFO] 2020-02-03 10:39:31,694 [-5443-exec-5] io.openvidu.server.recording.service.RecordingService (updateFilePermissions) - Individual recording file permissions successfully updated
[INFO] 2020-02-03 10:39:31,695 [-5443-exec-5] io.openvidu.server.recording.service.RecordingService (sealRecordingMetadataFile) - Sealed recording metadata file at /opt/openvidu/recordings/ouugkpwqrfotmt6x/.recording.ouugkpwqrfotmt6x
[ERROR] 2020-02-03 10:39:36,181 [5m67-e507-t0] io.openvidu.server.recording.service.RecordingManager (stopOneIndividualStreamRecording) - Error waiting for recorder endpoint of stream bcshbxxuv9ktrje4_CAMERA_QKIJH to stop in session ouugkpwqrfotmt6x
I know it looks like file permissions… but the server is deployed used cloudformation on AWS and this happen only a few times per day… all the other recordings are just fine.