[Solved]Streaming and recording stopping here with something went wrong

Hi All,

Just focusing on live steram (most important part to me)

After the last line of attached jibri log I have something went wrong message and client quit from conference.
On youtube I can see this error info in preview vindow, but no other…
No error in jicofo log, but really interesting in jvb log (see second log)
The interesting part around sockets and SCTP.
-SCTP connection with 39c39bcad96592b8 not ready yet
-No available transport channel, can’t send a message
Of course I had proper setup accorcing to advanced config (nat). And I’m able to estabilish conference crossing nat from different networks, it cannot be the issue. Somehow during stream session it comes.

jibri log (see the last recorded event when conference session goes to die)
2019-04-28 13:33:06.268 INFO: [27] org.jitsi.jibri.api.xmpp.XmppApi.handleJibriIq() Received JibriIq from environment prod environment
2019-04-28 13:33:06.273 INFO: [27] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Received start request
2019-04-28 13:33:06.308 INFO: [27] org.jitsi.jibri.api.xmpp.XmppApi.handleStartJibriIq() Sending ‘pending’ response to start IQ
2019-04-28 13:33:06.309 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.run() Starting service
2019-04-28 13:33:06.366 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.handleStartService() Parsed call url info: CallUrlInfo(baseUrl=https://webconf.globolearning.eu, callName=test, urlParams=)
2019-04-28 13:33:06.371 INFO: [40] org.jitsi.jibri.JibriManager.startStreaming() Starting a stream with params: ServiceParams(usageTimeoutMinutes=180, appData=null) StreamingParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://webconf.globolearning.eu, callName=test, urlParams=)), sessionId=lhzxcbnkaadvspln, callLoginParams=XmppCredentials(domain=recorder.webconf.globolearning.eu, username=recorder, password=jibrirecorderpass), youTubeStreamKey=0cw7-62yc-80p4-2wf9, youTubeBroadcastId=null)
2019-04-28 13:33:06.433 FINE: [40] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.() Detected os as OS: LINUX
2019-04-28 13:33:27.273 INFO: [40] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
2019-04-28 13:33:27.317 FINE: [40] org.jitsi.jibri.statsd.JibriStatsDClient.incrementCounter() Incrementing statsd counter: start:live_stream
2019-04-28 13:33:27.321 INFO: [40] org.jitsi.jibri.status.JibriStatusManager.log() Busy status has changed: IDLE -> BUSY
2019-04-28 13:33:27.323 INFO: [40] org.jitsi.jibri.api.xmpp.XmppApi.invoke() Jibri reports its status is now JibriStatus(busyStatus=BUSY, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connection prod environment
2019-04-28 13:33:27.328 INFO: [40] org.jitsi.jibri.JibriManager.startService() This service will have a usage timeout of 180 minute(s)
2019-04-28 13:33:39.107 FINE: [48] org.jitsi.jibri.selenium.pageobjects.CallPage.visit() Visiting url https://webconf.globolearning.eu/test#config.iAmRecorder=true&config.externalConnectUrl=null&config.startWithAudioMuted=true&config.startWithVideoMuted=true&interfaceConfig.APP_NAME=“Jibri”

JVB log

JVB 2019-04-28 11:37:31.914 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=7a3a4af5b4de4c96 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:37:32.130 SEVERE: [9510] org.ice4j.socket.MergingDatagramSocket.log() Cannot find socket to remove.
JVB 2019-04-28 11:37:32.130 SEVERE: [9508] org.ice4j.socket.MergingDatagramSocket.log() Cannot find socket to remove.
JVB 2019-04-28 11:37:32.177 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 263ms. Sticky failure: false
JVB 2019-04-28 11:37:38.377 FINE: [275] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-508):
JVB 2019-04-28 11:37:41.936 FINE: [288] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId kDhql-2572):
JVB 2019-04-28 11:37:41.941 FINE: [288] org.jitsi.videobridge.xmpp.ComponentImpl.processIQRequest() (serving component ‘JitsiVideobridge’) Processing IQ request (packetId kDhql-2572).
JVB 2019-04-28 11:37:41.952 FINE: [288] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Responding to IQ (packetId kDhql-2572) with:
JVB 2019-04-28 11:37:42.178 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=c6695916bd8270e5 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:37:42.319 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 141ms. Sticky failure: false
JVB 2019-04-28 11:37:42.480 INFO: [48] org.jitsi.videobridge.VideobridgeExpireThread.log() Running expire()
JVB 2019-04-28 11:37:48.388 FINE: [290] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-510):
JVB 2019-04-28 11:37:52.319 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=f4ea8cb0c050a6ac conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:37:52.574 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 255ms. Sticky failure: false
JVB 2019-04-28 11:37:58.353 FINE: [289] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-512):
JVB 2019-04-28 11:38:02.576 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=3ed0f1282641d342 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:38:02.632 WARNING: [45] org.jitsi.videobridge.EndpointMessageTransport.log() SCTP connection with 9fb9a63dd809ae8b not ready yet.
JVB 2019-04-28 11:38:02.632 WARNING: [45] org.jitsi.videobridge.EndpointMessageTransport.log() No available transport channel, can’t send a message
JVB 2019-04-28 11:38:02.632 WARNING: [45] org.jitsi.videobridge.EndpointMessageTransport.log() SCTP connection with 39c39bcad96592b8 not ready yet.
JVB 2019-04-28 11:38:02.632 WARNING: [45] org.jitsi.videobridge.EndpointMessageTransport.log() No available transport channel, can’t send a message
JVB 2019-04-28 11:38:02.774 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 198ms. Sticky failure: false
JVB 2019-04-28 11:38:08.355 FINE: [322] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-514):
JVB 2019-04-28 11:38:11.899 FINE: [385] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId kDhql-2590):
JVB 2019-04-28 11:38:11.899 FINE: [385] org.jitsi.videobridge.xmpp.ComponentImpl.processIQRequest() (serving component ‘JitsiVideobridge’) Processing IQ request (packetId kDhql-2590).
JVB 2019-04-28 11:38:11.900 FINE: [385] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Responding to IQ (packetId kDhql-2590) with:
JVB 2019-04-28 11:38:12.774 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=8732ff19c96617f8 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:38:12.898 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 124ms. Sticky failure: false
JVB 2019-04-28 11:38:18.377 FINE: [409] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-516):
JVB 2019-04-28 11:38:22.899 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=db63c792cd6424e4 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:38:22.983 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 85ms. Sticky failure: false
JVB 2019-04-28 11:38:28.383 FINE: [389] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-518):
JVB 2019-04-28 11:38:32.984 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=a6e3918da0b9ae43 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:38:33.090 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 107ms. Sticky failure: false
JVB 2019-04-28 11:38:38.371 FINE: [162] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId rs6AB-520):
JVB 2019-04-28 11:38:41.912 FINE: [416] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Processing IQ (packetId kDhql-2608):
JVB 2019-04-28 11:38:41.912 FINE: [416] org.jitsi.videobridge.xmpp.ComponentImpl.processIQRequest() (serving component ‘JitsiVideobridge’) Processing IQ request (packetId kDhql-2608).
JVB 2019-04-28 11:38:41.913 FINE: [416] org.jitsi.videobridge.xmpp.ComponentImpl.processIQ() (serving component ‘JitsiVideobridge’) Responding to IQ (packetId kDhql-2608) with:
JVB 2019-04-28 11:38:42.484 INFO: [48] org.jitsi.videobridge.VideobridgeExpireThread.log() Running expire()
JVB 2019-04-28 11:38:43.092 INFO: [49] org.jitsi.videobridge.Videobridge.log() CAT=stat create_conf,conf_id=2b3565b1b782d364 conf_name=null,logging=false,conf_count=1,ch_count=0,v_streams=0
JVB 2019-04-28 11:38:43.176 INFO: [49] org.jitsi.videobridge.health.Health.log() Performed a successful health check in 84ms. Sticky failure: false

Finally I have to reply myself with solution.

The real problem JVB have to be restarted after reboot. Somehow NAT related config not aplying correctly.

Not a new issue.