No audio in Jibri Recording


#1

Hi,

I have setup Jibri with Jitsi and I am able to record the conference. However, on playing the recording there is no audio. Can someone help me out here.?

Please find the jibri log.0.txt contents below:

2018-09-07 11:19:44.985 INFO: [1] org.jitsi.jibri.Main.main() Using config file /etc/jitsi/jibri/config.json
2018-09-07 11:19:45.553 INFO: [1] org.jitsi.jibri.Main.loadConfig() Parsed config:
JibriConfig(recordingDirectory=/srv/recordings, enabledStatsD=true, finalizeRecordingScriptPath=/path/to/finalize_recording.sh, xmppEnvironments=[XmppEnvironmentConfig(name=prod environment, xmppServerHosts=[10.115.3.53], xmppDomain=10.115.3.53, controlLogin=XmppCredentials(domain=auth.10.115.3.53, username=jibri, password=jibri), controlMuc=XmppMuc(domain=internal.auth.10.115.3.53, roomName=JibriBrewery, nickname=jibri-nickname), sipControlMuc=null, callLogin=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri), stripFromRoomDomain=conference., usageTimeoutMins=0, trustAllXmppCerts=true)])
2018-09-07 11:19:46.059 WARNING: [1] org.glassfish.jersey.internal.inject.Providers.checkProviderRuntime() A provider org.jitsi.jibri.api.http.internal.InternalHttpApi registered in SERVER runtime does not implement any provider interfaces applicable in the SERVER runtime. Due to constraint configuration problems the provider org.jitsi.jibri.api.http.internal.InternalHttpApi will be ignored. 
2018-09-07 11:19:46.320 INFO: [1] org.jitsi.jibri.api.xmpp.XmppApi.start() Connecting to xmpp environment on 10.115.3.53 with config XmppEnvironmentConfig(name=prod environment, xmppServerHosts=[10.115.3.53], xmppDomain=10.115.3.53, controlLogin=XmppCredentials(domain=auth.10.115.3.53, username=jibri, password=jibri), controlMuc=XmppMuc(domain=internal.auth.10.115.3.53, roomName=JibriBrewery, nickname=jibri-nickname), sipControlMuc=null, callLogin=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri), stripFromRoomDomain=conference., usageTimeoutMins=0, trustAllXmppCerts=true)
2018-09-07 11:19:46.328 INFO: [1] org.jitsi.jibri.api.xmpp.XmppApi.start() The trustAllXmppCerts config is enabled for this domain, all XMPP server provided certificates will be accepted
2018-09-07 11:19:46.517 INFO: [1] class org.jitsi.xmpp.mucclient.MucClient.connected() [prod environment: auth.10.115.3.53@10.115.3.53] Xmpp connection status: connected
2018-09-07 11:19:46.603 INFO: [1] class org.jitsi.xmpp.mucclient.MucClient.authenticated() [prod environment: auth.10.115.3.53@10.115.3.53] Xmpp connection status: authenticated (resume from previous? false)
2018-09-07 11:19:46.711 WARNING: [1] org.glassfish.jersey.internal.inject.Providers.checkProviderRuntime() A provider org.jitsi.jibri.api.http.HttpApi registered in SERVER runtime does not implement any provider interfaces applicable in the SERVER runtime. Due to constraint configuration problems the provider org.jitsi.jibri.api.http.HttpApi will be ignored. 
2018-09-07 11:20:34.026 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMTY4MADu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='audio1@conference.10.115.3.53' session_id='isysitdlpslyqoem'/></iq> from environment prod environment
2018-09-07 11:20:34.029 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2018-09-07 11:20:34.031 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending 'pending' response to start IQ
2018-09-07 11:20:34.032 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2018-09-07 11:20:34.038 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://10.115.3.53, callName=audio1, urlParams=[])
2018-09-07 11:20:34.039 INFO: [40] org.jitsi.jibri.JibriManager.startFileRecording() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://10.115.3.53, callName=audio1, urlParams=[])), sessionId=isysitdlpslyqoem, callLoginParams=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri)) finalize script path: /path/to/finalize_recording.sh and recordings directory: /srv/recordings
2018-09-07 11:20:35.298 INFO: [40] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2018-09-07 11:20:35.321 FINE: [40] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.<init>() Detected os as OS: LINUX
2018-09-07 11:20:35.337 INFO: [40] org.jitsi.jibri.service.impl.FileRecordingJibriService.<init>() Writing recording to /srv/recordings/isysitdlpslyqoem
2018-09-07 11:20:35.352 FINE: [40] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:recording
2018-09-07 11:20:35.353 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now busy, publishing presence to connection prod environment
2018-09-07 11:20:37.322 FINE: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://10.115.3.53/audio1#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME="Jibri"
2018-09-07 11:20:45.126 INFO: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Waited 11 milliseconds for call page to load
2018-09-07 11:20:45.146 INFO: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.launchFfmpeg() Starting ffmpeg with command [ffmpeg, -y, -v, info, -f, x11grab, -draw_mouse, 0, -r, 30, -s, 1280x720, -thread_queue_size, 4096, -i, :0.0+0,0, -f, alsa, -thread_queue_size, 4096, -i, hw:0,1,0, -acodec, aac, -strict, -2, -ar, 44100, -c:v, libx264, -preset, veryfast, -profile:v, main, -level, 3.1, -pix_fmt, yuv420p, -r, 30, -crf, 25, -g, 60, -tune, zerolatency, -f, mp4, /srv/recordings/isysitdlpslyqoem/audio1_2018-09-07-11-20-35.mp4]
2018-09-07 11:20:45.158 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: 
2018-09-07 11:20:46.161 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: [libx264 @ 0xafda60] profile Main, level 3.1
2018-09-07 11:20:47.162 FINE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg appears healthy: frame=   15 fps=0.0 q=26.0 size=     113kB time=00:00:00.50 bitrate=1850.1kbits/s    
2018-09-07 11:20:47.357 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Sending start service response iq: <iq to='jibribrewery@internal.auth.10.115.3.53/focus' id='akl4p-30' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='on'/></iq>
2018-09-07 11:21:07.652 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMTgwOQDu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='stop'/></iq> from environment prod environment
2018-09-07 11:21:07.656 FINE: [26] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: stop:recording
2018-09-07 11:21:07.657 INFO: [26] org.jitsi.jibri.JibriManager.stopService() Stopping the current service
2018-09-07 11:21:07.661 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Stopping capturer
2018-09-07 11:21:07.670 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Stopping ffmpeg process
2018-09-07 11:21:07.706 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Ffmpeg exited with value 255
2018-09-07 11:21:07.706 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Quitting selenium
2018-09-07 11:21:07.728 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Participants in this recording: []
2018-09-07 11:21:07.879 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 16 log entries for type browser
2018-09-07 11:21:08.140 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 1035 log entries for type driver
2018-09-07 11:21:08.413 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 0 log entries for type client
2018-09-07 11:21:08.414 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Leaving web call
2018-09-07 11:21:08.515 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Quitting chrome driver
2018-09-07 11:21:08.595 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Chrome driver quit
2018-09-07 11:21:08.596 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Finalizing the recording
2018-09-07 11:21:08.596 SEVERE: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize() Failed to run finalize script: java.io.IOException: Cannot run program "/path/to/finalize_recording.sh": error=2, No such file or directory with stack: 
java.lang.ProcessBuilder.start(ProcessBuilder.java:1048)
org.jitsi.jibri.util.ProcessWrapper.start(ProcessWrapper.kt:79)
org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize(FileRecordingJibriService.kt:214)
org.jitsi.jibri.service.impl.FileRecordingJibriService.stop(FileRecordingJibriService.kt:199)
org.jitsi.jibri.JibriManager.stopService(JibriManager.kt:238)
org.jitsi.jibri.api.xmpp.XmppApi.handleStopJibriIq(XmppApi.kt:253)
org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq(XmppApi.kt:163)
org.jitsi.jibri.api.xmpp.XmppApi.access$handleJibriIq(XmppApi.kt:64)
org.jitsi.jibri.api.xmpp.XmppApi$start$1.handleJibriIqRequest(XmppApi.kt:104)
org.jitsi.jibri.api.xmpp.JibriSyncIqRequestHandler.handleIQRequest(JibriSyncIqRequestHandler.kt:33)
org.jivesoftware.smack.AbstractXMPPConnection$3.run(AbstractXMPPConnection.java:1153)
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
java.lang.Thread.run(Thread.java:748)

2018-09-07 11:21:08.597 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now idle, publishing presence to connection prod environment
2018-09-07 11:22:21.875 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMTg5OADu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='quickdinosaurseatcalmly@conference.10.115.3.53' session_id='ikccnittbtvpaacr'/></iq> from environment prod environment
2018-09-07 11:22:21.876 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2018-09-07 11:22:21.876 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending 'pending' response to start IQ
2018-09-07 11:22:21.876 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2018-09-07 11:22:21.876 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://10.115.3.53, callName=quickdinosaurseatcalmly, urlParams=[])
2018-09-07 11:22:21.876 INFO: [40] org.jitsi.jibri.JibriManager.startFileRecording() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://10.115.3.53, callName=quickdinosaurseatcalmly, urlParams=[])), sessionId=ikccnittbtvpaacr, callLoginParams=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri)) finalize script path: /path/to/finalize_recording.sh and recordings directory: /srv/recordings
2018-09-07 11:22:22.424 INFO: [40] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2018-09-07 11:22:22.428 FINE: [40] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.<init>() Detected os as OS: LINUX
2018-09-07 11:22:22.437 INFO: [40] org.jitsi.jibri.service.impl.FileRecordingJibriService.<init>() Writing recording to /srv/recordings/ikccnittbtvpaacr
2018-09-07 11:22:22.438 FINE: [40] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:recording
2018-09-07 11:22:22.438 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now busy, publishing presence to connection prod environment
2018-09-07 11:22:24.565 FINE: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://10.115.3.53/quickdinosaurseatcalmly#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME="Jibri"
2018-09-07 11:22:27.142 INFO: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Waited 8 milliseconds for call page to load
2018-09-07 11:22:27.170 INFO: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.launchFfmpeg() Starting ffmpeg with command [ffmpeg, -y, -v, info, -f, x11grab, -draw_mouse, 0, -r, 30, -s, 1280x720, -thread_queue_size, 4096, -i, :0.0+0,0, -f, alsa, -thread_queue_size, 4096, -i, hw:0,1,0, -acodec, aac, -strict, -2, -ar, 44100, -c:v, libx264, -preset, veryfast, -profile:v, main, -level, 3.1, -pix_fmt, yuv420p, -r, 30, -crf, 25, -g, 60, -tune, zerolatency, -f, mp4, /srv/recordings/ikccnittbtvpaacr/quickdinosaurseatcalmly_2018-09-07-11-22-22.mp4]
2018-09-07 11:22:27.216 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: 
2018-09-07 11:22:28.217 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: [libx264 @ 0x9bda80] profile Main, level 3.1
2018-09-07 11:22:29.218 FINE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg appears healthy: frame=   15 fps=0.0 q=22.0 size=      80kB time=00:00:00.50 bitrate=1304.4kbits/s    
2018-09-07 11:22:29.288 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Sending start service response iq: <iq to='jibribrewery@internal.auth.10.115.3.53/focus' id='akl4p-44' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='on'/></iq>
2018-09-07 11:22:53.957 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMjAxNwDu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='stop'/></iq> from environment prod environment
2018-09-07 11:22:53.958 FINE: [26] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: stop:recording
2018-09-07 11:22:53.958 INFO: [26] org.jitsi.jibri.JibriManager.stopService() Stopping the current service
2018-09-07 11:22:53.959 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Stopping capturer
2018-09-07 11:22:53.959 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Stopping ffmpeg process
2018-09-07 11:22:54.019 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Ffmpeg exited with value 255
2018-09-07 11:22:54.019 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Quitting selenium
2018-09-07 11:22:54.034 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Participants in this recording: []
2018-09-07 11:22:54.079 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 16 log entries for type browser
2018-09-07 11:22:54.243 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 1002 log entries for type driver
2018-09-07 11:22:54.410 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 0 log entries for type client
2018-09-07 11:22:54.410 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Leaving web call
2018-09-07 11:22:54.507 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Quitting chrome driver
2018-09-07 11:22:54.581 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Chrome driver quit
2018-09-07 11:22:54.582 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Finalizing the recording
2018-09-07 11:22:54.583 SEVERE: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize() Failed to run finalize script: java.io.IOException: Cannot run program "/path/to/finalize_recording.sh": error=2, No such file or directory with stack: 
java.lang.ProcessBuilder.start(ProcessBuilder.java:1048)
org.jitsi.jibri.util.ProcessWrapper.start(ProcessWrapper.kt:79)
org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize(FileRecordingJibriService.kt:214)
org.jitsi.jibri.service.impl.FileRecordingJibriService.stop(FileRecordingJibriService.kt:199)
org.jitsi.jibri.JibriManager.stopService(JibriManager.kt:238)
org.jitsi.jibri.api.xmpp.XmppApi.handleStopJibriIq(XmppApi.kt:253)
org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq(XmppApi.kt:163)
org.jitsi.jibri.api.xmpp.XmppApi.access$handleJibriIq(XmppApi.kt:64)
org.jitsi.jibri.api.xmpp.XmppApi$start$1.handleJibriIqRequest(XmppApi.kt:104)
org.jitsi.jibri.api.xmpp.JibriSyncIqRequestHandler.handleIQRequest(JibriSyncIqRequestHandler.kt:33)
org.jivesoftware.smack.AbstractXMPPConnection$3.run(AbstractXMPPConnection.java:1153)
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
java.lang.Thread.run(Thread.java:748)

2018-09-07 11:22:54.583 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now idle, publishing presence to connection prod environment
2018-09-07 11:32:32.643 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMjUxNADu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='furiouswitchesconsumehumbly@conference.10.115.3.53' session_id='uxhjzlavipywmccg'/></iq> from environment prod environment
2018-09-07 11:32:32.644 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2018-09-07 11:32:32.644 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending 'pending' response to start IQ
2018-09-07 11:32:32.644 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2018-09-07 11:32:32.645 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://10.115.3.53, callName=furiouswitchesconsumehumbly, urlParams=[])
2018-09-07 11:32:32.645 INFO: [40] org.jitsi.jibri.JibriManager.startFileRecording() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://10.115.3.53, callName=furiouswitchesconsumehumbly, urlParams=[])), sessionId=uxhjzlavipywmccg, callLoginParams=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri)) finalize script path: /path/to/finalize_recording.sh and recordings directory: /srv/recordings
2018-09-07 11:32:33.138 INFO: [40] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2018-09-07 11:32:33.141 FINE: [40] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.<init>() Detected os as OS: LINUX
2018-09-07 11:32:33.142 INFO: [40] org.jitsi.jibri.service.impl.FileRecordingJibriService.<init>() Writing recording to /srv/recordings/uxhjzlavipywmccg
2018-09-07 11:32:33.142 FINE: [40] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:recording
2018-09-07 11:32:33.143 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now busy, publishing presence to connection prod environment
2018-09-07 11:32:35.353 FINE: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://10.115.3.53/furiouswitchesconsumehumbly#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME="Jibri"
2018-09-07 11:32:37.237 INFO: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Waited 551 milliseconds for call page to load
2018-09-07 11:32:37.274 INFO: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.launchFfmpeg() Starting ffmpeg with command [ffmpeg, -y, -v, info, -f, x11grab, -draw_mouse, 0, -r, 30, -s, 1280x720, -thread_queue_size, 4096, -i, :0.0+0,0, -f, alsa, -thread_queue_size, 4096, -i, hw:0,1,0, -acodec, aac, -strict, -2, -ar, 44100, -c:v, libx264, -preset, veryfast, -profile:v, main, -level, 3.1, -pix_fmt, yuv420p, -r, 30, -crf, 25, -g, 60, -tune, zerolatency, -f, mp4, /srv/recordings/uxhjzlavipywmccg/furiouswitchesconsumehumbly_2018-09-07-11-32-33.mp4]
2018-09-07 11:32:37.293 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: 
2018-09-07 11:32:38.293 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: [libx264 @ 0x1795a60] profile Main, level 3.1
2018-09-07 11:32:39.294 FINE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg appears healthy: frame=   14 fps=0.0 q=21.0 size=       5kB time=00:00:00.46 bitrate=  81.6kbits/s    
2018-09-07 11:32:39.371 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Sending start service response iq: <iq to='jibribrewery@internal.auth.10.115.3.53/focus' id='akl4p-92' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='on'/></iq>
2018-09-07 11:32:58.943 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctMjU5NADu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='stop'/></iq> from environment prod environment
2018-09-07 11:32:58.946 FINE: [26] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: stop:recording
2018-09-07 11:32:58.947 INFO: [26] org.jitsi.jibri.JibriManager.stopService() Stopping the current service
2018-09-07 11:32:58.949 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Stopping capturer
2018-09-07 11:32:58.950 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Stopping ffmpeg process
2018-09-07 11:32:59.021 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Ffmpeg exited with value 255
2018-09-07 11:32:59.026 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Quitting selenium
2018-09-07 11:32:59.037 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Participants in this recording: []
2018-09-07 11:32:59.087 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 23 log entries for type browser
2018-09-07 11:32:59.203 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 807 log entries for type driver
2018-09-07 11:32:59.504 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 0 log entries for type client
2018-09-07 11:32:59.505 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Leaving web call
2018-09-07 11:32:59.600 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Quitting chrome driver
2018-09-07 11:32:59.673 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Chrome driver quit
2018-09-07 11:32:59.674 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Finalizing the recording
2018-09-07 11:32:59.674 SEVERE: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize() Failed to run finalize script: java.io.IOException: Cannot run program "/path/to/finalize_recording.sh": error=2, No such file or directory with stack: 
java.lang.ProcessBuilder.start(ProcessBuilder.java:1048)
org.jitsi.jibri.util.ProcessWrapper.start(ProcessWrapper.kt:79)
org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize(FileRecordingJibriService.kt:214)
org.jitsi.jibri.service.impl.FileRecordingJibriService.stop(FileRecordingJibriService.kt:199)
org.jitsi.jibri.JibriManager.stopService(JibriManager.kt:238)
org.jitsi.jibri.api.xmpp.XmppApi.handleStopJibriIq(XmppApi.kt:253)
org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq(XmppApi.kt:163)
org.jitsi.jibri.api.xmpp.XmppApi.access$handleJibriIq(XmppApi.kt:64)
org.jitsi.jibri.api.xmpp.XmppApi$start$1.handleJibriIqRequest(XmppApi.kt:104)
org.jitsi.jibri.api.xmpp.JibriSyncIqRequestHandler.handleIQRequest(JibriSyncIqRequestHandler.kt:33)
org.jivesoftware.smack.AbstractXMPPConnection$3.run(AbstractXMPPConnection.java:1153)
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
java.lang.Thread.run(Thread.java:748)

2018-09-07 11:32:59.674 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now idle, publishing presence to connection prod environment
2018-09-07 12:26:26.545 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctNTE5OQDu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='audio2@conference.10.115.3.53' session_id='rwbolpbtqdemtozr'/></iq> from environment prod environment
2018-09-07 12:26:26.546 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2018-09-07 12:26:26.546 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending 'pending' response to start IQ
2018-09-07 12:26:26.547 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2018-09-07 12:26:26.547 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://10.115.3.53, callName=audio2, urlParams=[])
2018-09-07 12:26:26.547 INFO: [40] org.jitsi.jibri.JibriManager.startFileRecording() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://10.115.3.53, callName=audio2, urlParams=[])), sessionId=rwbolpbtqdemtozr, callLoginParams=XmppCredentials(domain=recorder.10.115.3.53, username=recorder, password=jibri)) finalize script path: /path/to/finalize_recording.sh and recordings directory: /srv/recordings
2018-09-07 12:26:27.090 INFO: [40] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2018-09-07 12:26:27.091 FINE: [40] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.<init>() Detected os as OS: LINUX
2018-09-07 12:26:27.091 INFO: [40] org.jitsi.jibri.service.impl.FileRecordingJibriService.<init>() Writing recording to /srv/recordings/rwbolpbtqdemtozr
2018-09-07 12:26:27.092 FINE: [40] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:recording
2018-09-07 12:26:27.092 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now busy, publishing presence to connection prod environment
2018-09-07 12:26:29.190 FINE: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://10.115.3.53/audio2#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME="Jibri"
2018-09-07 12:26:31.227 INFO: [40] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Waited 8 milliseconds for call page to load
2018-09-07 12:26:31.235 INFO: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.launchFfmpeg() Starting ffmpeg with command [ffmpeg, -y, -v, info, -f, x11grab, -draw_mouse, 0, -r, 30, -s, 1280x720, -thread_queue_size, 4096, -i, :0.0+0,0, -f, alsa, -thread_queue_size, 4096, -i, hw:0,1,0, -acodec, aac, -strict, -2, -ar, 44100, -c:v, libx264, -preset, veryfast, -profile:v, main, -level, 3.1, -pix_fmt, yuv420p, -r, 30, -crf, 25, -g, 60, -tune, zerolatency, -f, mp4, /srv/recordings/rwbolpbtqdemtozr/audio2_2018-09-07-12-26-27.mp4]
2018-09-07 12:26:31.242 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: 
2018-09-07 12:26:32.243 SEVERE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg is running but doesn't appear to be encoding: [libx264 @ 0x19db7a0] profile Main, level 3.1
2018-09-07 12:26:33.244 FINE: [40] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.isFfmpegHealthy() Ffmpeg appears healthy: frame=   14 fps=0.0 q=21.0 size=      12kB time=00:00:00.46 bitrate= 203.6kbits/s    
2018-09-07 12:26:33.298 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Sending start service response iq: <iq to='jibribrewery@internal.auth.10.115.3.53/focus' id='akl4p-314' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='on'/></iq>
2018-09-07 12:26:50.922 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq <iq to='jibri@auth.10.115.3.53/eb065fcc-684e-473c-b0ab-d300cb90dd4b' from='jibribrewery@internal.auth.10.115.3.53/focus' id='amlicmlAYXV0aC4xMC4xMTUuMy41My9lYjA2NWZjYy02ODRlLTQ3M2MtYjBhYi1kMzAwY2I5MGRkNGIAMmJwaFctNTMxNADu0w4QBaPb6duOwpaDqu8J' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='stop'/></iq> from environment prod environment
2018-09-07 12:26:50.922 FINE: [26] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: stop:recording
2018-09-07 12:26:50.922 INFO: [26] org.jitsi.jibri.JibriManager.stopService() Stopping the current service
2018-09-07 12:26:50.922 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Stopping capturer
2018-09-07 12:26:50.923 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Stopping ffmpeg process
2018-09-07 12:26:50.954 INFO: [26] org.jitsi.jibri.capture.ffmpeg.executor.FfmpegExecutor.stopFfmpeg() Ffmpeg exited with value 255
2018-09-07 12:26:50.955 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Quitting selenium
2018-09-07 12:26:50.962 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Participants in this recording: []
2018-09-07 12:26:50.971 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 16 log entries for type browser
2018-09-07 12:26:51.089 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 1072 log entries for type driver
2018-09-07 12:26:51.279 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Got 0 log entries for type client
2018-09-07 12:26:51.279 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Leaving web call
2018-09-07 12:26:51.341 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Quitting chrome driver
2018-09-07 12:26:51.414 INFO: [26] org.jitsi.jibri.selenium.JibriSelenium.leaveCallAndQuitBrowser() Chrome driver quit
2018-09-07 12:26:51.414 INFO: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.stop() Finalizing the recording
2018-09-07 12:26:51.415 SEVERE: [26] org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize() Failed to run finalize script: java.io.IOException: Cannot run program "/path/to/finalize_recording.sh": error=2, No such file or directory with stack: 
java.lang.ProcessBuilder.start(ProcessBuilder.java:1048)
org.jitsi.jibri.util.ProcessWrapper.start(ProcessWrapper.kt:79)
org.jitsi.jibri.service.impl.FileRecordingJibriService.finalize(FileRecordingJibriService.kt:214)
org.jitsi.jibri.service.impl.FileRecordingJibriService.stop(FileRecordingJibriService.kt:199)
org.jitsi.jibri.JibriManager.stopService(JibriManager.kt:238)
org.jitsi.jibri.api.xmpp.XmppApi.handleStopJibriIq(XmppApi.kt:253)
org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq(XmppApi.kt:163)
org.jitsi.jibri.api.xmpp.XmppApi.access$handleJibriIq(XmppApi.kt:64)
org.jitsi.jibri.api.xmpp.XmppApi$start$1.handleJibriIqRequest(XmppApi.kt:104)
org.jitsi.jibri.api.xmpp.JibriSyncIqRequestHandler.handleIQRequest(JibriSyncIqRequestHandler.kt:33)
org.jivesoftware.smack.AbstractXMPPConnection$3.run(AbstractXMPPConnection.java:1153)
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
java.lang.Thread.run(Thread.java:748)

2018-09-07 12:26:51.415 INFO: [26] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now idle, publishing presence to connection prod environment


No sound of jibri recording
#2

Is No sound of jibri recording the same topic?


#3

Hi @lmarinov,

The problem i believe is same, but i didn’t find the solution there, hence posted a new topic with logs, if someone can help me out.

Thanks,
Abhijit