Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Users disconnected and Failed to allocate colibri channels #2011

Open
rscho11 opened this issue Feb 5, 2025 · 0 comments
Open

Users disconnected and Failed to allocate colibri channels #2011

rscho11 opened this issue Feb 5, 2025 · 0 comments

Comments

@rscho11
Copy link

rscho11 commented Feb 5, 2025

I am having an issue with my docker jitsi deployment and am having trouble figuring out what is causing it. The issue occurred quite sometime after updating to stable-9258 in January 2024. November 2024 it was reported that users were being disconnected from the room, though we hadn't made any changes. I updated to stable-9955 since then and this is the behavior I have seen:
Users can create a room and join by themselves, no issue, however when a second user joins the room one of two things can happen :

1. (Most Common) One of the two clients has video and audio, while the other shows no video and audio for the other client - in this case after about 10 seconds both users are disconnected, the room is closed and in the jicofo container logs I see an exception:

   Jicofo 2025-02-04 19:56:23.582 SEVERE: [55] [[email protected] meeting_id=12f6df13-a5a7-4f40-b885-9e82e7c8ea75] ColibriV2SessionManager.allocate#396: Failed to allocate a colibri2 endpoint for a56f6cc6: Timeout
        Jicofo 2025-02-04 19:56:23.586 SEVERE: [55] [[email protected] meeting_id=12f6df13-a5a7-4f40-b885-9e82e7c8ea75 participant=a56f6cc6] ParticipantInviteRunnable.doRun#230: Failed to allocate colibri channels
        org.jitsi.jicofo.bridge.colibri.ColibriAllocationFailedException: Timeout
        at org.jitsi.jicofo.bridge.colibri.ColibriV2SessionManager.handleResponse(ColibriV2SessionManager.kt:435)
        at org.jitsi.jicofo.bridge.colibri.ColibriV2SessionManager.allocate(ColibriV2SessionManager.kt:391)
        at org.jitsi.jicofo.conference.ParticipantInviteRunnable.doRun(ParticipantInviteRunnable.java:214)
        at org.jitsi.jicofo.conference.ParticipantInviteRunnable.run(ParticipantInviteRunnable.java:153)
        at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
        at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
        at java.base/java.lang.Thread.run(Thread.java:840)

2. Both users have video, but no audio, they never get disconnected and there are no errors in any logs - it's almost working perfectly, but no audio.

jvb.conf (in container):



videobridge {
    cc {
        use-vla-target-bitrate = false
        trust-bwe = true
    }
    ice {
        udp {
            port = 10000
        }
        advertise-private-candidates = true
    }
    apis {
xmpp-client {
            configs {


                shard0 {
                    HOSTNAME = "xmpp.meet.jitsi"
                    PORT = "5222"
                    DOMAIN = "auth.meet.jitsi"
                    USERNAME = "jvb"
                    PASSWORD = "xxxxxxxxxx"
                    MUC_JIDS = "[email protected]"
                    MUC_NICKNAME = "aaaaaaaaa"
                    DISABLE_CERTIFICATE_VERIFICATION = true
                }
}
        }
rest {
            enabled = true
        }
    }
    rest {
        shutdown {
            enabled = false
        }
    }
    sctp {
      enabled = true
      use-usrsctp = false
    }
    stats {
        enabled = true
    }
    websockets {
        enabled = true
        domain = "jitsi.xxxx.com"
        tls = true
        server-id = "xxx.xx.xxx.4"
    }
    http-servers {
        private {
          host = 0.0.0.0
          send-server-version = false
        }
        public {
            host = 0.0.0.0
            port = 9090
            send-server-version = false
        }
    }
    health {
        require-valid-address = false
    }

    colibri2 {
    enabled = true
    }


    }

ice4j {
    harvest {
        mapping {
            stun {
addresses = [ "meet-jit-si-turnrelay.jitsi.net:443" ]
}
            static-mappings = [
{
                    local-address = "xxx.xx.xxx.4"
                    public-address = "x.xx.xxx.10"
                    name = "ip-0"
                },
]
        }
    }
}

include "custom-jvb.conf"

jicofo.conf (in container):

jicofo {

    authentication {
      enabled = true
      // The type of authentication. Supported values are XMPP or JWT.

      type = JWT

      login-url = "meet.jitsi"
      enable-auto-login = true
      authentication-lifetime = 24 hours
    }


    // Configuration related to jitsi-videobridge
    bridge {













      brewery-jid = "[email protected]"



    }
    // Configure the codecs and RTP extensions to be used in the offer sent to clients.
    codec {
      video {




      }
      audio {

      }
      rtp-extensions {
        video-layers-allocation {
          enabled = false
        }
      }
    }

    conference {






      max-ssrcs-per-user = "20"

      max-ssrc-groups-per-user = "20"















    }











    octo {
      // Whether or not to use Octo. Note that when enabled, its use will be determined by
      // $jicofo.bridge.selection-strategy. There's a corresponding flag in the JVB and these
      // two MUST be in sync (otherwise bridges will crash because they won't know how to
      // deal with octo channels).
      enabled = false
      sctp-datachannels = true
    }



    sctp {
      enabled = true
    }

    xmpp {

      client {
        enabled = true
        hostname = "xmpp.meet.jitsi"
        port = "5222"
        domain = "auth.meet.jitsi"
        xmpp-domain = "meet.jitsi"
        username = "focus"
        password = "xxxxxxxxx"
        conference-muc-jid = "muc.meet.jitsi"
        client-proxy = "focus.meet.jitsi"
        disable-certificate-verification = true
      }


      trusted-domains = [  ]

    }
}

Here is some of the troubleshooting that I have done:

  • Checked jvb.log and saw this warning :
JVB 2025-02-04 22:38:06.449 WARNING: [24] [hostname=xmpp.meet.jitsi id=shard0] MucClient.setPresenceExtensions#519: Cannot set presence extension: not connected

Suggesting JVB is not connecting to Prosody - I docker exec'd into the JVB container and ran :

curl -v telnet://xmpp.meet.jitsi:5222
                *   Trying xxx.xx.xxx.3:5222...
                * Connected to xmpp.meet.jitsi (xxx.xx.xxx.3) port 5222 (#0)

It seems it can reach prosody

  • Check JVB logs for errors during disconnect, none were found

  • Check firewall - its inactive, shouldn't be causing any issues - sudo ufw status" returned : Status:inactive

  • UDP port 10000 is open - having checked with iptables

  • I have ensured that JWT app id and JWT app token on prosody container matches corresponding values in .env

  • I have ensured that containers are all correctly attached to the same docker network via running - docker network ls, docker network inspect ff6a11bffc58

  • Checked resource consumption for jvb container : docker stats <container_id_for_jvb> - no major spikes during disconnect

  • All containers are running the same version 9955

  • Checked to see if (JVB) is communicating with the MUC (Multi-User Chat) - In the logs : from="[email protected]/focus" JVB is receiving requests

  • Checked to see if JVB is properly joining the MUC - prosodyctl mod_muc list | grep jvbbrewery

    • No output here, I tried to manually add a muc room : prosodyctl --config /config/prosody.cfg.lua addroom [email protected] and list again afterwards, but no room was being created.
    • Running prosodyctl --config /config/prosody.cfg.lua check revealed several issues - most prominent is : Host internal-muc.meet.jitsi does not seem to resolve to this server (IPv4/IPv6) So I added "external_addresses" the jitsi-meet.cfg.lua - No change in behavior
  • Noticed that the certs configured in /config/conf.d jitsi-meet.cfg.lua were expired - renewed them and restarted cluster - no fix

  • Configuring DOCKER_HOST_ADRESS to private ip address of machine - no fix

  • Added colibri configuration to jvb.conf - it was never there before when everything worked, but I added it to see - Colibri is enabled but I dont see anything in the JVB logs about Colibri when restarting jvb container

  • I noticed in the prosody logs the following:
    2025-02-04 22:37:21 mod_http error Not listening on any ports, 'health' will be unreachable
    - I added "http"; to the :enabled plugins" section and now users are disconnected instantaneously with no colibri error in the jicofo logs

I have noticed that the /etc/hosts file on the prosody container does not contain any entries for meet.jitsi, auth.meet.jitsi, muc.meet.jitsi, and internal-muc.meet.jitsi - I am working to get those added from the host machine because they get wiped with every restart of the container.

  • Just digging around i noticed that in my prosody.cfg.lua and my jitsi-meet.cfg.lua did not have the following settings :
 Component "focus.meet.jitsi" "client_proxy"
    target_address = "[email protected]"
    component_secret = "xxxx"

and

component_secret = "xxxx"

I added them matching the value in my .env file which led to the same behavior after restart of the jicofo and prosody containers - that is - disconnect after about 10 seconds after the second user joins or -less frequently - no disconnect but no sound.

I added the logs that I captured during an attempt that led to a disconnect in the hopes that It may help:

web_1      | 184.182.198.10 - - [11/Feb/2025:17:10:54 +0000] "GET /ad0a4911-ed20-4535-8b5a-8e861f65ef03?jwt=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdXNlcjIifX0sImV4cCI6MTczOTI5NzQ1Mywicm9vbSI6ImFkMGE0OTExLWVkMjAtNDUzNS04YjVhLThlODYxZjY1ZWYwMyJ9.4ahXya6Cn0YkyKb65LyV4khnfPBKzeJRTJPzuorMUGo HTTP/2.0" 200 9147 "https://ttl.blackbirdlabs.com/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
web_1      | 184.182.198.10 - - [11/Feb/2025:17:10:54 +0000] "GET /libs/excalidraw-assets/vendor-75e22c20f1d603abdfc9.js HTTP/2.0" 200 187108 "https://jitsi.gothamworkshop.com/ad0a4911-ed20-4535-8b5a-8e861f65ef03?jwt=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdXNlcjIifX0sImV4cCI6MTczOTI5NzQ1Mywicm9vbSI6ImFkMGE0OTExLWVkMjAtNDUzNS04YjVhLThlODYxZjY1ZWYwMyJ9.4ahXya6Cn0YkyKb65LyV4khnfPBKzeJRTJPzuorMUGo" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
prosody_1  | 2025-02-11 17:10:58 c2s55f1a7f029e0                                              info      Client connected
prosody_1  | 2025-02-11 17:10:58 c2s55f1a7f029e0                                              info      Authenticated as [email protected]
web_1      | 184.182.198.10 - - [11/Feb/2025:17:10:58 +0000] "GET /libs/lib-jitsi-meet.e2ee-worker.js HTTP/2.0" 200 6053 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
jicofo_1   | Jicofo 2025-02-11 17:10:58.670 INFO: [60] ConferenceIqHandler.handleConferenceIq#87: Conference request for room [email protected], from [email protected]/BVK4doW8oEk2
jicofo_1   | Jicofo 2025-02-11 17:10:59.727 INFO: [60] ConferenceIqHandler.handleConferenceIq#87: Conference request for room [email protected], from [email protected]/BVK4doW8oEk2
jicofo_1   | Jicofo 2025-02-11 17:10:59.727 INFO: [60] AbstractAuthAuthority.createNewSession#158: Authentication session created for [email protected] SID: 6aa8c26f-7ae3-4640-993e-ab890a512b49
jicofo_1   | Jicofo 2025-02-11 17:10:59.727 INFO: [60] AbstractAuthAuthority.authenticateJidWithSession#431: Authenticated jid: [email protected]/BVK4doW8oEk2 with session: AuthSession[[email protected], [email protected]/BVK4doW8oEk2, SID=6aa8c26f-7ae3-4640-993e-ab890a512b49, MUID=86138c058a68235b6d19d4c2ceea8a53, LIFE_TM_SEC=0, [email protected]]@615002888
jicofo_1   | Jicofo 2025-02-11 17:10:59.727 INFO: [60] AbstractAuthAuthority.notifyUserAuthenticated#339: Jid [email protected]/BVK4doW8oEk2 authenticated as: [email protected]
jicofo_1   | Jicofo 2025-02-11 17:10:59.728 INFO: [60] [[email protected]] JitsiMeetConferenceImpl.<init>#308: Created new conference.
jicofo_1   | Jicofo 2025-02-11 17:10:59.728 INFO: [60] [[email protected]] JitsiMeetConferenceImpl.joinTheRoom#511: Joining [email protected]
jicofo_1   | Jicofo 2025-02-11 17:10:59.834 INFO: [83] [xmpp_connection=client] XmppProvider.discoverFeatures#286: Discovered features for [email protected]/e59cabb8 in 0 ms.
jicofo_1   | Jicofo 2025-02-11 17:10:59.834 INFO: [83] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.onMemberJoined#750: Member joined:e59cabb8 stats-id=Neha-b9D region=null audioMuted=true videoMuted=true role=PARTICIPANT isJibri=false isJigasi=false isTranscriber=false, room=main
web_1      | 184.182.198.10 - - [11/Feb/2025:17:11:05 +0000] "GET /ad0a4911-ed20-4535-8b5a-8e861f65ef03?jwt=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdGVzdCJ9fSwiZXhwIjoxNzM5Mjk3NDY1LCJyb29tIjoiYWQwYTQ5MTEtZWQyMC00NTM1LThiNWEtOGU4NjFmNjVlZjAzIn0.ojySqKGhVVtVOMhIPTGSjQHsA0e1Xt-c3V19Tf0NPls HTTP/2.0" 200 9147 "https://ttl.blackbirdlabs.com/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
web_1      | 184.182.198.10 - - [11/Feb/2025:17:11:06 +0000] "GET /libs/excalidraw-assets/vendor-75e22c20f1d603abdfc9.js HTTP/2.0" 200 187108 "https://jitsi.gothamworkshop.com/ad0a4911-ed20-4535-8b5a-8e861f65ef03?jwt=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdGVzdCJ9fSwiZXhwIjoxNzM5Mjk3NDY1LCJyb29tIjoiYWQwYTQ5MTEtZWQyMC00NTM1LThiNWEtOGU4NjFmNjVlZjAzIn0.ojySqKGhVVtVOMhIPTGSjQHsA0e1Xt-c3V19Tf0NPls" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
prosody_1  | 2025-02-11 17:11:07 c2s55f1a81448d0                                              info      Client connected
prosody_1  | 2025-02-11 17:11:07 c2s55f1a81448d0                                              info      Authenticated as [email protected]
web_1      | 184.182.198.10 - - [11/Feb/2025:17:11:08 +0000] "GET /libs/lib-jitsi-meet.e2ee-worker.js HTTP/2.0" 200 6053 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
jicofo_1   | Jicofo 2025-02-11 17:11:08.200 INFO: [60] ConferenceIqHandler.handleConferenceIq#87: Conference request for room [email protected], from [email protected]/rz1sSWDVf01Y
jicofo_1   | Jicofo 2025-02-11 17:11:09.311 INFO: [60] ConferenceIqHandler.handleConferenceIq#87: Conference request for room [email protected], from [email protected]/rz1sSWDVf01Y
jicofo_1   | Jicofo 2025-02-11 17:11:09.311 INFO: [60] AbstractAuthAuthority.createNewSession#158: Authentication session created for [email protected] SID: e9b17dab-dde0-459a-92d6-3ba3bb7f9cbe
jicofo_1   | Jicofo 2025-02-11 17:11:09.311 INFO: [60] AbstractAuthAuthority.authenticateJidWithSession#431: Authenticated jid: [email protected]/rz1sSWDVf01Y with session: AuthSession[[email protected], [email protected]/rz1sSWDVf01Y, SID=e9b17dab-dde0-459a-92d6-3ba3bb7f9cbe, MUID=495fade0349d7f435995824865881e11, LIFE_TM_SEC=0, [email protected]]@2109509196
jicofo_1   | Jicofo 2025-02-11 17:11:09.311 INFO: [60] AbstractAuthAuthority.notifyUserAuthenticated#339: Jid [email protected]/rz1sSWDVf01Y authenticated as: [email protected]
jicofo_1   | Jicofo 2025-02-11 17:11:09.371 INFO: [60] [xmpp_connection=client] XmppProvider.discoverFeatures#286: Discovered features for [email protected]/8e68e9c1 in 0 ms.
jicofo_1   | Jicofo 2025-02-11 17:11:09.371 INFO: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.onMemberJoined#750: Member joined:8e68e9c1 stats-id=Marcella-roR region=null audioMuted=true videoMuted=true role=PARTICIPANT isJibri=false isJigasi=false isTranscriber=false, room=main
jicofo_1   | Jicofo 2025-02-11 17:11:09.372 INFO: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.inviteChatMember#822: Creating participant e59cabb8 with features=[XMPP_CAPS, JSON_SOURCES, RECEIVE_MULTIPLE_STREAMS, REMB, SOURCE_NAMES, SSRC_REWRITING_V1, TCC, VISITORS_V1, E2EE, RTX, JINGLE, DTLS, JINGLE_RTP, AUDIO, VIDEO, SCTP, JINGLE_ICE, RAYO]
jicofo_1   | Jicofo 2025-02-11 17:11:09.373 INFO: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.<init>#80: Using org.jitsi.jicofo.bridge.SingleMeshTopologyStrategy
jicofo_1   | Jicofo 2025-02-11 17:11:09.374 INFO: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.inviteChatMember#822: Creating participant 8e68e9c1 with features=[XMPP_CAPS, JSON_SOURCES, RECEIVE_MULTIPLE_STREAMS, REMB, SOURCE_NAMES, SSRC_REWRITING_V1, TCC, VISITORS_V1, E2EE, RTX, JINGLE, DTLS, JINGLE_RTP, AUDIO, VIDEO, SCTP, JINGLE_ICE, RAYO]
jicofo_1   | Jicofo 2025-02-11 17:11:09.377 INFO: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#280: Allocating for e59cabb8
jicofo_1   | Jicofo 2025-02-11 17:11:09.377 INFO: [84] BridgeSelectionStrategy.select#109: Selected initial bridge Bridge[[email protected]/f1989c2159e0, version=2.3.198-g5ff19598, relayId=null, region=null, stress=0.01] with reported stress=0.00501002004008016 for participantProperties=ParticipantProperties(region=null, visitor=false) using strategy SingleBridgeSelectionStrategy
jicofo_1   | Jicofo 2025-02-11 17:11:09.378 INFO: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#280: Allocating for 8e68e9c1
jicofo_1   | Jicofo 2025-02-11 17:11:09.379 INFO: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#326: Selected f1989c2159e0 for $e59cabb8 (visitor=false, session exists: false)
jicofo_1   | Jicofo 2025-02-11 17:11:09.380 INFO: [85] BridgeSelectionStrategy.select#122: Existing bridge does not have a relay, will not consider other bridges.
jicofo_1   | Jicofo 2025-02-11 17:11:09.380 INFO: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#326: Selected f1989c2159e0 for $8e68e9c1 (visitor=false, session exists: true)
jvb_1      | JVB 2025-02-11 17:11:09.385 INFO: [74] [confId=695c8246b777917d [email protected] meeting_id=d655d068] EndpointConnectionStatusMonitor.start#58: Starting connection status monitor
jvb_1      | JVB 2025-02-11 17:11:09.390 INFO: [74] Videobridge.createConference#213: create_conf, id=695c8246b777917d meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e
jvb_1      | JVB 2025-02-11 17:11:09.416 INFO: [75] [confId=695c8246b777917d [email protected] meeting_id=d655d068] Conference.lambda$new$1#227: RECV colibri2 request: <iq xmlns="jabber:client" to="[email protected]/VAiISDhc_t67" from="[email protected]/focus" id="anZiQGF1dGgubWVldC5qaXRzaS9WQWlJU0RoY190NjcATEk5UlMtMzgAgSWbk0dg9Sk=" type="get"><conference-modify xmlns="jitsi:colibri2" meeting-id="d655d068-a559-4fa5-b101-42a8b533cf0e" name="[email protected]" rtcstats-enabled="false" create="true"><endpoint create="true" stats-id="Neha-b9D" id="e59cabb8"><media type="audio"><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" name="opus" clockrate="48000" id="111" channels="2"><parameter value="10" name="minptime"/><parameter value="1" name="useinbandfec"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="8000" id="126" name="telephone-event"/><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="1" uri="urn:ietf:params:rtp-hdrext:ssrc-audio-level"/><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="5" uri="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01"/><extmap-allow-mixed xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0"/></media><media type="video"><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="41" name="AV1"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="100" name="VP8"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="107" name="H264"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/><parameter value="42e01f;level-asymmetry-allowed=1;packetization-mode=1;" name="profile-level-id"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="101" name="VP9"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="42" name="rtx"><parameter value="41" name="apt"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="96" name="rtx"><parameter value="100" name="apt"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="97" name="rtx"><parameter value="101" name="apt"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="ccm" subtype="fir"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack" subtype="pli"/></payload-type><payload-type xmlns="urn:xmpp:jingle:apps:rtp:1" clockrate="90000" id="99" name="rtx"><parameter value="107" name="apt"/></payload-type><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="11" uri="https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"/><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="3" uri="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time"/><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="5" uri="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01"/><extmap-allow-mixed xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0"/></media><transport ice-controlling="true"><sctp/></transport><sources/><capability name="source-names"/><capability name="ssrc-rewriting"/></endpoint></conference-modify></iq>
jicofo_1   | Jicofo 2025-02-11 17:11:24.380 SEVERE: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#396: Failed to allocate a colibri2 endpoint for e59cabb8: Timeout
jicofo_1   | Jicofo 2025-02-11 17:11:24.381 SEVERE: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e participant=e59cabb8] ParticipantInviteRunnable.doRun#230: Failed to allocate colibri channels
jicofo_1   | org.jitsi.jicofo.bridge.colibri.ColibriAllocationFailedException: Timeout
jicofo_1   |    at org.jitsi.jicofo.bridge.colibri.ColibriV2SessionManager.handleResponse(ColibriV2SessionManager.kt:435)
jicofo_1   |    at org.jitsi.jicofo.bridge.colibri.ColibriV2SessionManager.allocate(ColibriV2SessionManager.kt:391)
jicofo_1   |    at org.jitsi.jicofo.conference.ParticipantInviteRunnable.doRun(ParticipantInviteRunnable.java:214)
jicofo_1   |    at org.jitsi.jicofo.conference.ParticipantInviteRunnable.run(ParticipantInviteRunnable.java:153)
jicofo_1   |    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
jicofo_1   |    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
jicofo_1   |    at java.base/java.lang.Thread.run(Thread.java:840)
jicofo_1   | Jicofo 2025-02-11 17:11:24.382 INFO: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl$ColibriSessionManagerListener.bridgeRemoved#2553: Bridge Bridge[[email protected]/f1989c2159e0, version=2.3.198-g5ff19598, relayId=null, region=null, stress=0.02] was removed from the conference. Re-inviting its participants: [e59cabb8, 8e68e9c1]
jicofo_1   | Jicofo 2025-02-11 17:11:24.383 INFO: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#377: Ignoring response for a session that's no longer active ([email protected]/f1989c2159e0)
jicofo_1   | Jicofo 2025-02-11 17:11:24.383 SEVERE: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e participant=8e68e9c1] ParticipantInviteRunnable.doRun#230: Failed to allocate colibri channels
jicofo_1   | org.jitsi.jicofo.bridge.colibri.ColibriAllocationFailedException: Session no longer active ([email protected]/f1989c2159e0)
jicofo_1   |    at org.jitsi.jicofo.bridge.colibri.ColibriV2SessionManager.allocate(ColibriV2SessionManager.kt:378)
jicofo_1   |    at org.jitsi.jicofo.conference.ParticipantInviteRunnable.doRun(ParticipantInviteRunnable.java:214)
jicofo_1   |    at org.jitsi.jicofo.conference.ParticipantInviteRunnable.run(ParticipantInviteRunnable.java:153)
jicofo_1   |    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
jicofo_1   |    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
jicofo_1   |    at java.base/java.lang.Thread.run(Thread.java:840)
jicofo_1   | Jicofo 2025-02-11 17:11:24.385 WARNING: [60] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e participant=8e68e9c1] Participant.setInviteRunnable#155: Canceling ParticipantInviteRunnable[Participant[[email protected]/8e68e9c1]]@179883885
jicofo_1   | Jicofo 2025-02-11 17:11:24.386 INFO: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#280: Allocating for 8e68e9c1
jicofo_1   | Jicofo 2025-02-11 17:11:24.387 WARNING: [85] BridgeSelector.selectBridge#182: There are no operational bridges.
jicofo_1   | Jicofo 2025-02-11 17:11:24.387 SEVERE: [85] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e participant=8e68e9c1] ParticipantInviteRunnable.doRun#218: Can not invite participant, no bridge available.
jicofo_1   | Jicofo 2025-02-11 17:11:24.387 INFO: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.allocate#280: Allocating for e59cabb8
jicofo_1   | Jicofo 2025-02-11 17:11:24.388 WARNING: [84] BridgeSelector.selectBridge#182: There are no operational bridges.
jicofo_1   | Jicofo 2025-02-11 17:11:24.388 SEVERE: [84] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e participant=e59cabb8] ParticipantInviteRunnable.doRun#218: Can not invite participant, no bridge available.
jicofo_1   | Jicofo 2025-02-11 17:11:24.504 INFO: [82] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.onMemberLeft#964: Member left:8e68e9c1
jicofo_1   | Jicofo 2025-02-11 17:11:24.505 INFO: [82] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.terminateParticipant#1051: Terminating 8e68e9c1, reason: gone, send session-terminate: false
jicofo_1   | Jicofo 2025-02-11 17:11:24.505 INFO: [82] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.terminateParticipant#1065: Removed participant 8e68e9c1 removed=true
jicofo_1   | Jicofo 2025-02-11 17:11:24.506 WARNING: [82] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.removeParticipant#128: Can not remove 8e68e9c1, no participantInfo
jicofo_1   | Jicofo 2025-02-11 17:11:24.506 INFO: [82] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.rescheduleSingleParticipantTimeout#2125: Scheduled single person timeout.
jicofo_1   | Jicofo 2025-02-11 17:11:24.510 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.onMemberLeft#964: Member left:e59cabb8
jicofo_1   | Jicofo 2025-02-11 17:11:24.511 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.terminateParticipant#1051: Terminating e59cabb8, reason: gone, send session-terminate: false
jicofo_1   | Jicofo 2025-02-11 17:11:24.511 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.terminateParticipant#1065: Removed participant e59cabb8 removed=true
jicofo_1   | Jicofo 2025-02-11 17:11:24.511 WARNING: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.removeParticipant#128: Can not remove e59cabb8, no participantInfo
jicofo_1   | Jicofo 2025-02-11 17:11:24.511 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.expire#112: Expiring.
jicofo_1   | Jicofo 2025-02-11 17:11:24.512 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.maybeStop#1019: Last member left, stopping.
jicofo_1   | Jicofo 2025-02-11 17:11:24.512 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] ColibriV2SessionManager.expire#112: Expiring.
jicofo_1   | Jicofo 2025-02-11 17:11:24.513 INFO: [81] [[email protected] meeting_id=d655d068-a559-4fa5-b101-42a8b533cf0e] JitsiMeetConferenceImpl.stop#483: Stopped.
jicofo_1   | Jicofo 2025-02-11 17:11:24.514 INFO: [81] AbstractAuthAuthority.conferenceEnded#302: Removing session for ended conference, S: AuthSession[[email protected], [email protected]/BVK4doW8oEk2, SID=6aa8c26f-7ae3-4640-993e-ab890a512b49, MUID=86138c058a68235b6d19d4c2ceea8a53, LIFE_TM_SEC=24, [email protected]]@615002888
jicofo_1   | Jicofo 2025-02-11 17:11:24.514 INFO: [81] AbstractAuthAuthority.conferenceEnded#302: Removing session for ended conference, S: AuthSession[[email protected], [email protected]/rz1sSWDVf01Y, SID=e9b17dab-dde0-459a-92d6-3ba3bb7f9cbe, MUID=495fade0349d7f435995824865881e11, LIFE_TM_SEC=15, [email protected]]@2109509196
prosody_1  | 2025-02-11 17:11:24 meetingended.meet.jitsi:meeting_ended_component              info      Room destroyed: [email protected]
prosody_1  | 2025-02-11 17:11:24 c2s55f1a81448d0                                              info      Client disconnected: connection closed
web_1      | 184.182.198.10 - - [11/Feb/2025:17:11:24 +0000] "GET /xmpp-websocket?room=ad0a4911-ed20-4535-8b5a-8e861f65ef03&token=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdGVzdCJ9fSwiZXhwIjoxNzM5Mjk3NDY1LCJyb29tIjoiYWQwYTQ5MTEtZWQyMC00NTM1LThiNWEtOGU4NjFmNjVlZjAzIn0.ojySqKGhVVtVOMhIPTGSjQHsA0e1Xt-c3V19Tf0NPls HTTP/1.1" 101 31175 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
prosody_1  | 2025-02-11 17:11:24 c2s55f1a7f029e0                                              info      Client disconnected: connection closed
web_1      | 184.182.198.10 - - [11/Feb/2025:17:11:24 +0000] "GET /xmpp-websocket?room=ad0a4911-ed20-4535-8b5a-8e861f65ef03&token=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdWQiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJpc3MiOiJqaXRzaS5nb3RoYW13b3Jrc2hvcC5jb20iLCJjb250ZXh0Ijp7InVzZXIiOnsibmFtZSI6InJzY2hvb2wtdXNlcjIifX0sImV4cCI6MTczOTI5NzQ1Mywicm9vbSI6ImFkMGE0OTExLWVkMjAtNDUzNS04YjVhLThlODYxZjY1ZWYwMyJ9.4ahXya6Cn0YkyKb65LyV4khnfPBKzeJRTJPzuorMUGo HTTP/1.1" 101 33024 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36"
prosody_1  | 2025-02-11 17:11:24 meetingended.meet.jitsi:meeting_ended_component              info      request callback response: {
prosody_1  |   "convId" : "347397-350817",
prosody_1  |   "jitsiEvent" : "RoomTerminated",
prosody_1  |   "media" : {
prosody_1  |     "roomId" : "ad0a4911-ed20-4535-8b5a-8e861f65ef03",
prosody_1  |     "platform" : "jitsi"
prosody_1  |   },
prosody_1  |   "entityId" : "0"
prosody_1  | }

Plesse note the last entry in the log (prosody_1) is a custom plugin that I have created.

I have tried many things to try and figure what is going on, any advice or insight would be greatly appreciated - thank you very much.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

1 participant