Jibri - working but not working!

I’ve got a bit of an odd one I think…

So, I’ve finally got Jibri working after lots of hassle. It does now start recording and I did a few quick tests and it saves the files, all good!

Today we’ve tried to record our first meeting… and it says its recording, but after about 20 seconds it stops. It does create the save file, but it isn’t playable. If however I start recording and stop it myself after 5 or 6 seconds, it all works fine and is recorded perfectly again.

Any ideas?

@damencho - any ideas please?

Please include Jibri logs

I think the most relevant bit is this, but as I say, it does record 5 - 10 seconds worth:

2020-05-19 19:07:55.135 INFO: [55] org.jitsi.jibri.status.JibriStatusManager.log() Busy status has changed: BUSY -> IDLE
2020-05-19 19:07:55.135 INFO: [55] org.jitsi.jibri.api.xmpp.XmppApi.updatePresence() Jibri reports its status is now JibriStatus(busyStatus=IDLE, health=OverallHealth(healthStatus=HEALTHY, 2020-05-19 19:07:55.135 INFO: [55] org.jitsi.xmpp.mucclient.MucClientManager.log() Setting a presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@777a9d32 2020-05-19 19:07:55.143 INFO: [69] org.jitsi.jibri.JibriManager.stopService() No service active, ignoring stop 2020-05-19 19:08:28.662 INFO: [73] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.stagestars.online/ff07dbf3-93a7-40d3-9770-264146300b07' from='jibrib
2020-05-19 19:08:28.663 INFO: [73] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2020-05-19 19:08:28.664 INFO: [69] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2020-05-19 19:08:28.670 INFO: [73] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending ‘pending’ response to start IQ
2020-05-19 19:08:28.689 INFO: [69] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://stagestars.online, callName=stagkatie, urlParams= 2020-05-19 19:08:28.689 INFO: [69] org.jitsi.jibri.JibriManager.startFileRecording() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=Cal
2020-05-19 19:08:29.607 INFO: [69] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2020-05-19 19:08:29.623 INFO: [69] org.jitsi.jibri.selenium.JibriSelenium.() Starting empty call check with a timeout of PT30S
2020-05-19 19:08:29.624 FINE: [69] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.() Detected os as OS: LINUX
2020-05-19 19:08:29.624 INFO: [69] org.jitsi.jibri.service.impl.FileRecordingJibriService.() Writing recording to /srv/recordings/hwjbwmjjlsqokyjh
2020-05-19 19:08:29.624 FINE: [69] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:recording
2020-05-19 19:08:29.625 INFO: [69] org.jitsi.jibri.status.JibriStatusManager.log() Busy status has changed: IDLE -> BUSY
2020-05-19 19:08:29.625 INFO: [69] org.jitsi.jibri.api.xmpp.XmppApi.updatePresence() Jibri reports its status is now JibriStatus(busyStatus=BUSY, health=OverallHealth(healthStatus=HEALTHY, 2020-05-19 19:08:29.625 INFO: [69] org.jitsi.xmpp.mucclient.MucClientManager.log() Setting a presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@f655ee8 2020-05-19 19:08:31.228 FINE: [70] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://stagestars.online/stagkatie#config.iAmRecorder=true&config.externalConnectUrl=
2020-05-19 19:08:56.572 INFO: [73] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to=‘jibri@auth.stagestars.online/ff07dbf3-93a7-40d3-9770-264146300b07’ from='jibrib$
2020-05-19 19:08:56.574 FINE: [73] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: stop:recording
2020-05-19 19:08:56.576 INFO: [73] org.jitsi.jibri.JibriManager.stopService() Stopping the current service
2020-05-19 19:08:56.576 INFO: [73] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Stopping capturer
2020-05-19 19:08:56.577 INFO: [73] org.jitsi.jibri.util.JibriSubprocess.ffmpeg.stop() Stopping ffmpeg process
2020-05-19 19:08:56.577 INFO: [73] org.jitsi.jibri.util.JibriSubprocess.ffmpeg.stop() ffmpeg exited with value null
2020-05-19 19:08:56.577 INFO: [73] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Quitting selenium
2020-05-19 19:08:56.590 INFO: [73] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Participants in this recording:
2020-05-19 19:08:56.635 INFO: [73] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 12 log entries for type browser
2020-05-19 19:08:56.694 INFO: [73] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 953 log entries for type driver
2020-05-19 19:08:56.788 INFO: [73] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 0 log entries for type client
2020-05-19 19:08:56.788 INFO: [73] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Leaving web call
2020-05-19 19:09:01.859 SEVERE: [73] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Error trying to leave the call: org.openqa.selenium.JavascriptException: javascript er$
(Session info: chrome=81.0.4044.138)
(Driver info: chromedriver=81.0.4044.138 (8c6c7ba89cc9453625af54f11fd83179e23450fa-refs/branch-heads/4044@{#999}),platform=Linux 4.19.0-9-amd64 x86_64) (WARNING: The server did not provi$
Command duration or timeout: 0 milliseconds
Build info: version: ‘unknown’, revision: ‘unknown’, time: ‘unknown’
System info: host: ‘recorder.stagestars.online’, ip: ‘127.0.0.1’, os.name: ‘Linux’, os.arch: ‘amd64’, os.version: ‘4.19.0-9-amd64’, java.version: ‘1.8.0_252’
Driver info: org.openqa.selenium.chrome.ChromeDriver
Capabilities {acceptInsecureCerts: false, acceptSslCerts: false, applicationCacheEnabled: false, browserConnectionEnabled: false, browserName: chrome, chrome: {chromedriverVersion: 81.0.40$
Session ID: f3abfe802e7baad3045275b00717b618 with stack:
sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)

Can you attach all the Jibri logs?