Hello:
I’ve just installed Jibri following this tutorial everything seems to be just fine when the recording starts but after a few seconds I get an error telling me that the video recording failed to start. Upon validating on the logs I see the following error:
Blockquote 2023-05-06 16:05:32.955 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading ‘isJoined’)
Here is the full log
2023-05-06 16:05:30.379 INFO: [63] XmppApi.handleJibriIq#236: Received JibriIq <iq xmlns='jabber:client' to='jibri@auth.meet.vranetworks.com/mEmpYKbcIXD0' from='jibribrewery@internal.auth.meet.vranetworks.com/focus' id='amlicmlAYXV0aC5tZWV0LnZyYW5ldHdvcmtzLmNvbS9tRW1wWUtiY0lYRDAARUdIWlYtMjgyAIqhuCvJzyo1' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='standup@conference.meet.vranetworks.com' session_id='qoylrdpcfochyrox' app_data='{"file_recording_metadata":{"share":true}}'/></iq> from environment [MucClient id=172.17.1.156 hostname=172.17.1.156]
2023-05-06 16:05:30.379 INFO: [63] XmppApi.handleStartJibriIq#268: Received start request, starting service
2023-05-06 16:05:30.385 INFO: [63] XmppApi.handleStartService#379: Parsed call url info: CallUrlInfo(baseUrl=https://meet.vranetworks.com, callName=standup, urlParams=[])
2023-05-06 16:05:30.385 INFO: [63] JibriManager.startFileRecording#138: Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://meet.vranetworks.com, callName=standup, urlParams=[]), email='', passcode=null, callStatsUsernameOverride=, displayName=), sessionId=qoylrdpcfochyrox, callLoginParams=XmppCredentials(domain=recorder.meet.vranetworks.com.com, port=null, username=recorder, password=*****))
2023-05-06 16:05:30.386 FINE: [63] [session_id=qoylrdpcfochyrox] FfmpegCapturer.<init>#92: Detected os as OS: LINUX
2023-05-06 16:05:30.576 INFO: [63] org.openqa.selenium.remote.ProtocolHandshake.createSession: Detected dialect: OSS
2023-05-06 16:05:30.586 INFO: [63] [session_id=qoylrdpcfochyrox] FileRecordingJibriService.<init>#134: Writing recording to /srv/recordings/qoylrdpcfochyrox, finalize script path /path/to/finalize
2023-05-06 16:05:30.586 FINE: [63] JibriStatsDClient.incrementCounter#38: Incrementing statsd counter: start:recording
2023-05-06 16:05:30.588 INFO: [63] JibriStatusManager$special$$inlined$observable$1.afterChange#72: Busy status has changed: IDLE -> BUSY
2023-05-06 16:05:30.589 FINE: [63] WebhookClient$updateStatus$1.invokeSuspend#109: Updating 0 subscribers of status
2023-05-06 16:05:30.589 INFO: [63] XmppApi.updatePresence#209: Jibri reports its status is now JibriStatus(busyStatus=BUSY, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connections
2023-05-06 16:05:30.597 INFO: [63] XmppApi.handleStartJibriIq#281: Sending 'pending' response to start IQ
2023-05-06 16:05:30.597 INFO: [74] AbstractPageObject.visit#32: Visiting url https://meet.vranetworks.com
2023-05-06 16:05:32.169 INFO: [74] AbstractPageObject.visit#38: Waited 1.571571646s for driver to load page
2023-05-06 16:05:32.259 INFO: [74] AbstractPageObject.visit#32: Visiting url https://meet.vranetworks.com/standup#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME="Jibri"&config.analytics.disabled=true&config.p2p.enabled=false&config.prejoinPageEnabled=false&config.prejoinConfig.enabled=false&config.requireDisplayName=false
2023-05-06 16:05:32.944 INFO: [74] AbstractPageObject.visit#38: Waited 684.080350ms for driver to load page
2023-05-06 16:05:32.955 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:33.474 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:33.996 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:34.517 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:35.033 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:35.550 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:36.061 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:36.579 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:37.091 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:37.608 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:38.119 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:38.636 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:39.148 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:39.666 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:40.180 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:40.698 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:41.213 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:41.731 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:42.245 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:42.763 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:43.275 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:43.793 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:44.307 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:44.825 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:45.339 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:45.856 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:46.368 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:46.884 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:47.399 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:47.916 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:48.434 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:48.953 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:49.469 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:49.985 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:50.501 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:51.018 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:51.536 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:52.053 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:52.575 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:53.091 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:53.609 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:54.121 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:54.848 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:55.370 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:55.880 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:56.399 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:56.915 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:57.431 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:57.941 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:58.456 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:58.969 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:59.484 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:05:59.999 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:00.515 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:01.029 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:01.546 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:02.056 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:02.573 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:03.086 FINE: [74] CallPage.visit$lambda-2$lambda-1#58: Not joined yet: Cannot read properties of undefined (reading 'isJoined')
2023-05-06 16:06:03.087 SEVERE: [74] CallPage.visit#65: Timed out waiting for call page to load
2023-05-06 16:06:03.088 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.onSeleniumStateChange#216: Transitioning from state Starting up to Error: FailedToJoinCall SESSION Failed to join the call
2023-05-06 16:06:03.088 INFO: [74] [session_id=qoylrdpcfochyrox] StatefulJibriService.onServiceStateChange#39: File recording service transitioning from state Starting up to Error: FailedToJoinCall SESSION Failed to join the call
2023-05-06 16:06:03.088 INFO: [74] XmppApi$createServiceStatusHandler$1.invoke#317: Current service had an error Error: FailedToJoinCall SESSION Failed to join the call, sending error iq <iq xmlns='jabber:client' to='jibribrewery@internal.auth.meet.vranetworks.com/focus' id='MN8K7-24' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='off' failure_reason='error' should_retry='true'/></iq>
2023-05-06 16:06:03.088 FINE: [74] JibriStatsDClient.incrementCounter#38: Incrementing statsd counter: stop:recording
2023-05-06 16:06:03.089 INFO: [74] JibriManager.stopService#260: Stopping the current service
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] FileRecordingJibriService.stop#182: Stopping capturer
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSubprocess.stop#75: Stopping ffmpeg process
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSubprocess.stop#89: ffmpeg exited with value null
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] FileRecordingJibriService.stop#184: Quitting selenium
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] FileRecordingJibriService.stop#191: No media was recorded, deleting directory and skipping metadata file & finalize
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#338: Leaving call and quitting browser
2023-05-06 16:06:03.090 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#341: Recurring call status checks cancelled
2023-05-06 16:06:03.105 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#347: Got 26 log entries for type browser
2023-05-06 16:06:03.160 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#347: Got 1405 log entries for type driver
2023-05-06 16:06:03.243 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#347: Got 0 log entries for type client
2023-05-06 16:06:03.244 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#356: Leaving web call
2023-05-06 16:06:03.260 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#363: Quitting chrome driver
2023-05-06 16:06:03.331 INFO: [74] [session_id=qoylrdpcfochyrox] JibriSelenium.leaveCallAndQuitBrowser#365: Chrome driver quit
2023-05-06 16:06:03.331 INFO: [74] JibriStatusManager$special$$inlined$observable$1.afterChange#72: Busy status has changed: BUSY -> IDLE
2023-05-06 16:06:03.331 FINE: [74] WebhookClient$updateStatus$1.invokeSuspend#109: Updating 0 subscribers of status
2023-05-06 16:06:03.331 INFO: [74] XmppApi.updatePresence#209: Jibri reports its status is now JibriStatus(busyStatus=IDLE, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connections
2023-05-06 16:06:18.145 FINE: [18] WebhookClient$updateStatus$1.invokeSuspend#109: Updating 0 subscribers of status
So far I’ve tried everything on the related topics but nothing seems to fix this error.
What am I missing?