2025-05-21T14:28:42.088Z WARN openvidu service/auth.go:95 error handling request {"status": 401, "method": "GET", "path": "/rtc", "error": "invalid token: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE3NDc4MzY5MjQsImlzcyI6IkFQSTNBZDBaYXBqUXB1diIsIm5hbWUiOiJNYXR0ZW8gUmVzY29uaSIsIm5iZiI6MTc0NzgzNjMyNCwic3ViIjoiTWF0dGVvIFJlc2NvbmkiLCJ2aWRlbyI6eyJjYW5VcGRhdGVPd25NZXRhZGF0YSI6dHJ1ZSwicm9vbSI6InJlcy0xMCIsInJvb21Kb2luIjp0cnVlfX0.bn5qDdrzfiAD1UTpGwWOSMgY1XT9y0cajZ6PLJszb3A, error: go-jose/go-jose/jwt: validation failed, token is expired (exp)"} 2025-05-21T14:28:50.140Z WARN openvidu service/auth.go:95 error handling request {"status": 401, "method": "GET", "path": "/rtc", "error": "invalid token: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE3NDc4MzY5MjQsImlzcyI6IkFQSTNBZDBaYXBqUXB1diIsIm5hbWUiOiJNYXR0ZW8gUmVzY29uaSIsIm5iZiI6MTc0NzgzNjMyNCwic3ViIjoiTWF0dGVvIFJlc2NvbmkiLCJ2aWRlbyI6eyJjYW5VcGRhdGVPd25NZXRhZGF0YSI6dHJ1ZSwicm9vbSI6InJlcy0xMCIsInJvb21Kb2luIjp0cnVlfX0.bn5qDdrzfiAD1UTpGwWOSMgY1XT9y0cajZ6PLJszb3A, error: go-jose/go-jose/jwt: validation failed, token is expired (exp)"} 2025-05-21T14:56:55.684Z INFO openvidu service/roommanager.go:394 removing duplicate participant {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_Sbz9d6XvPt2f", "remote": false} 2025-05-21T14:56:55.684Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_Sbz9d6XvPt2f", "remote": false, "sendLeave": true, "reason": "DUPLICATE_IDENTITY", "isExpectedToResume": false} 2025-05-21T14:56:55.685Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc004139ae0].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc0032d5a40].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-21T14:56:55.691Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "BRFVTpkc312QGh0ZfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "JkrH1evo9LY4OmcgfGcOof9h33U7CJ7IKfQDXfk7TpnC"} 2025-05-21T14:56:56.063Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T14:56:56.064Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T14:56:56.064Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:54640 (resolved: ***.***.***.***:54640)", "[local] tcp4 host ***.***.***.***:58528 (resolved: ***.***.***.***:58528)", "[local][selected:1] udp4 host ***.***.***.***:50847 (resolved: ***.***.***.***:50847)", "[local] tcp4 host ***.***.***.***:51035 (resolved: ***.***.***.***:51035)", "[local] udp4 host ***.***.***.***:56232 (resolved: ***.***.***.***:56232)", "[local] tcp4 host ***.***.***.***:57918 (resolved: ***.***.***.***:57918)", "[remote][trickle] udp4 host ***.***.***.***:56996", "[remote][trickle] udp4 host ***.***.***.***:56997", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:56998", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:56999", "[remote][trickle] udp4 srflx 93.91.143....:56997 related ***.***.***.***:56997", "[remote][trickle] udp4 relay 15.161.237....:42722 related 93.91.143....:56997", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:56997"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:57922 (resolved: ***.***.***.***:57922)", "[local] tcp4 host ***.***.***.***:59191 (resolved: ***.***.***.***:59191)", "[local][selected:1] udp4 host ***.***.***.***:54569 (resolved: ***.***.***.***:54569)", "[local] tcp4 host ***.***.***.***:54139 (resolved: ***.***.***.***:54139)", "[local] udp4 host ***.***.***.***:52339 (resolved: ***.***.***.***:52339)", "[local] tcp4 host ***.***.***.***:56632 (resolved: ***.***.***.***:56632)", "[remote][trickle] udp4 host ***.***.***.***:56992", "[remote][trickle] udp4 host ***.***.***.***:56993", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:56994", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:56995", "[remote][trickle] udp4 srflx 93.91.143....:56993 related ***.***.***.***:56993", "[remote][trickle] udp4 relay 15.161.237....:47213 related 93.91.143....:56993", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:56993"], "connectionType": "udp"} 2025-05-21T14:56:56.068Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_viALwXznHUbg", "webhookTime": 1747839416, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "25.011µs", "sendDuration": "4.19603ms"} 2025-05-21T14:56:56.071Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "260.736µs", "status": "200"} 2025-05-21T14:56:56.074Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_viALwXznHUbg", "webhookTime": 1747839416, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "92.788µs", "sendDuration": "9.688128ms"} 2025-05-21T14:56:56.079Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "transport": "PUBLISHER"} 2025-05-21T14:56:56.079Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "transport": "PUBLISHER"} 2025-05-21T14:57:05.737Z INFO openvidu.transport rtc/transport.go:564 ice reconnected or switched pair {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "transport": "SUBSCRIBER", "existingPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 54569, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "93.91.143....", "remotePort": 56993}, "newPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 57922, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "***.***.***.***", "remotePort": 47213}} 2025-05-21T14:58:22.758Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-21T14:58:22.762Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_gz7VomigmSfN", "webhookTime": 1747839502, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "112.03µs", "sendDuration": "3.904672ms"} 2025-05-21T14:58:22.765Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "226.355µs", "status": "200"} 2025-05-21T14:58:22.767Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_gz7VomigmSfN", "webhookTime": 1747839502, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_gHFCmwrJSTTA", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "109.153µs", "sendDuration": "8.13271ms"} 2025-05-21T14:58:28.197Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc0038cb720].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc00394edc0].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-21T14:58:28.203Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "ZZXUjZWc1UWYhN1YfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "Zq23aO5W7eH0xymAHazxRDoNMIBOkCGqM4qz21w5gME"} 2025-05-21T14:58:28.518Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T14:58:28.519Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T14:58:28.519Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:53849 (resolved: ***.***.***.***:53849)", "[local] tcp4 host ***.***.***.***:55024 (resolved: ***.***.***.***:55024)", "[local][selected:1] udp4 host ***.***.***.***:52786 (resolved: ***.***.***.***:52786)", "[local] tcp4 host ***.***.***.***:50486 (resolved: ***.***.***.***:50486)", "[local] udp4 host ***.***.***.***:52794 (resolved: ***.***.***.***:52794)", "[local] tcp4 host ***.***.***.***:53480 (resolved: ***.***.***.***:53480)", "[remote][trickle] udp4 host ***.***.***.***:63884", "[remote][trickle] udp4 host ***.***.***.***:63885", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:63886", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:63887", "[remote][trickle] udp4 srflx 93.91.143....:63885 related ***.***.***.***:63885", "[remote][trickle] udp4 relay 15.161.237....:46844 related 93.91.143....:63885", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:63885"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:58811 (resolved: ***.***.***.***:58811)", "[local] tcp4 host ***.***.***.***:54545 (resolved: ***.***.***.***:54545)", "[local][selected:1] udp4 host ***.***.***.***:53361 (resolved: ***.***.***.***:53361)", "[local] tcp4 host ***.***.***.***:58137 (resolved: ***.***.***.***:58137)", "[local] udp4 host ***.***.***.***:58870 (resolved: ***.***.***.***:58870)", "[local] tcp4 host ***.***.***.***:51458 (resolved: ***.***.***.***:51458)", "[remote][trickle] udp4 host ***.***.***.***:63880", "[remote][trickle] udp4 host ***.***.***.***:63881", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:63882", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:63883", "[remote][trickle] udp4 srflx 93.91.143....:63881 related ***.***.***.***:63881", "[remote][trickle] udp4 relay 15.161.237....:47815 related 93.91.143....:63881", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:63881"], "connectionType": "udp"} 2025-05-21T14:58:28.524Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_84nmb69wNFFN", "webhookTime": 1747839508, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "64.962µs", "sendDuration": "5.015969ms"} 2025-05-21T14:58:28.525Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "206.389µs", "status": "200"} 2025-05-21T14:58:28.527Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_84nmb69wNFFN", "webhookTime": 1747839508, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "101.533µs", "sendDuration": "8.289946ms"} 2025-05-21T14:58:28.544Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "transport": "PUBLISHER"} 2025-05-21T14:58:28.544Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:01:15.361Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-21T15:01:15.368Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "284.639µs", "status": "200"} 2025-05-21T15:01:15.368Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_bswucaCW6eYQ", "webhookTime": 1747839675, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "204.798µs", "sendDuration": "6.678546ms"} 2025-05-21T15:01:15.371Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_bswucaCW6eYQ", "webhookTime": 1747839675, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_cSaae5qfcQvY", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "118.062µs", "sendDuration": "9.364146ms"} 2025-05-21T15:01:19.843Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc003dae320].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc003daf040].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-21T15:01:19.849Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "jNXU4VlUzJkTHVGNfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "grsgjSt4U3gqlDsqeArCNUWSbep1wzY5pzEoBqURBH7"} 2025-05-21T15:01:20.171Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:01:20.172Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:01:20.172Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:50332 (resolved: ***.***.***.***:50332)", "[local] tcp4 host ***.***.***.***:51423 (resolved: ***.***.***.***:51423)", "[local][selected:1] udp4 host ***.***.***.***:53782 (resolved: ***.***.***.***:53782)", "[local] tcp4 host ***.***.***.***:55680 (resolved: ***.***.***.***:55680)", "[local] udp4 host ***.***.***.***:52461 (resolved: ***.***.***.***:52461)", "[local] tcp4 host ***.***.***.***:53969 (resolved: ***.***.***.***:53969)", "[remote][trickle] udp4 host ***.***.***.***:64292", "[remote][trickle] udp4 host ***.***.***.***:64293", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:64294", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:64295", "[remote][trickle] udp4 srflx 93.91.143....:64293 related ***.***.***.***:64293", "[remote][trickle] udp4 relay 15.161.237....:47707 related 93.91.143....:64293", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:64293"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:59413 (resolved: ***.***.***.***:59413)", "[local] tcp4 host ***.***.***.***:59699 (resolved: ***.***.***.***:59699)", "[local][selected:1] udp4 host ***.***.***.***:55866 (resolved: ***.***.***.***:55866)", "[local] tcp4 host ***.***.***.***:57549 (resolved: ***.***.***.***:57549)", "[local] udp4 host ***.***.***.***:53225 (resolved: ***.***.***.***:53225)", "[local] tcp4 host ***.***.***.***:59291 (resolved: ***.***.***.***:59291)", "[remote][trickle] udp4 host ***.***.***.***:64288", "[remote][trickle] udp4 host ***.***.***.***:64289", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:64290", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:64291", "[remote][trickle] udp4 srflx 93.91.143....:64289 related ***.***.***.***:64289", "[remote][trickle] udp4 relay 15.161.237....:43684 related 93.91.143....:64289", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:64289"], "connectionType": "udp"} 2025-05-21T15:01:20.176Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_V29cHQadkxCh", "webhookTime": 1747839680, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "25.986µs", "sendDuration": "3.919708ms"} 2025-05-21T15:01:20.177Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "276.61µs", "status": "200"} 2025-05-21T15:01:20.178Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_V29cHQadkxCh", "webhookTime": 1747839680, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "93.354µs", "sendDuration": "6.277566ms"} 2025-05-21T15:01:20.189Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:01:20.189Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:01:27.359Z INFO openvidu.transport rtc/transport.go:564 ice reconnected or switched pair {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "PUBLISHER", "existingPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 53782, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "93.91.143....", "remotePort": 64293}, "newPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 50332, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "***.***.***.***", "remotePort": 47707}} 2025-05-21T15:01:27.438Z INFO openvidu.transport rtc/transport.go:564 ice reconnected or switched pair {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "transport": "SUBSCRIBER", "existingPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 55866, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "93.91.143....", "remotePort": 64289}, "newPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 59413, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "***.***.***.***", "remotePort": 43684}} 2025-05-21T15:04:29.433Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-21T15:04:29.436Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_VQC8HQp5uHYC", "webhookTime": 1747839869, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "183.329µs", "sendDuration": "2.871104ms"} 2025-05-21T15:04:29.438Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "213.647µs", "status": "200"} 2025-05-21T15:04:29.440Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_VQC8HQp5uHYC", "webhookTime": 1747839869, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_4eGNBsRUxQsc", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "122.21µs", "sendDuration": "6.611478ms"} 2025-05-21T15:04:33.976Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc0039c0500].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc0038ca140].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-21T15:04:33.982Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "rhTaTxEVad0ZUdDdfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "JovH1ASl8mIbvEenIZYfREivc4gToiJLdbefvkhsSXUD"} 2025-05-21T15:04:34.318Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:04:34.319Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:04:34.319Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:55936 (resolved: ***.***.***.***:55936)", "[local] tcp4 host ***.***.***.***:59500 (resolved: ***.***.***.***:59500)", "[local][selected:1] udp4 host ***.***.***.***:59431 (resolved: ***.***.***.***:59431)", "[local] tcp4 host ***.***.***.***:55677 (resolved: ***.***.***.***:55677)", "[local] udp4 host ***.***.***.***:58668 (resolved: ***.***.***.***:58668)", "[local] tcp4 host ***.***.***.***:53802 (resolved: ***.***.***.***:53802)", "[remote][trickle] udp4 host ***.***.***.***:53974", "[remote][trickle] udp4 host ***.***.***.***:53975", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:53976", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:53977", "[remote][trickle] udp4 srflx 93.91.143....:53975 related ***.***.***.***:53975", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][trickle] udp4 relay 15.161.237....:46777 related 93.91.143....:53975", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:53975"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:53327 (resolved: ***.***.***.***:53327)", "[local] tcp4 host ***.***.***.***:55931 (resolved: ***.***.***.***:55931)", "[local][selected:1] udp4 host ***.***.***.***:50649 (resolved: ***.***.***.***:50649)", "[local] tcp4 host ***.***.***.***:50347 (resolved: ***.***.***.***:50347)", "[local] udp4 host ***.***.***.***:55275 (resolved: ***.***.***.***:55275)", "[local] tcp4 host ***.***.***.***:54275 (resolved: ***.***.***.***:54275)", "[remote][trickle] udp4 host ***.***.***.***:53970", "[remote][trickle] udp4 host ***.***.***.***:53971", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:53972", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:53973", "[remote][trickle] udp4 srflx 93.91.143....:53971 related ***.***.***.***:53971", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][trickle] udp4 relay 15.161.237....:49948 related 93.91.143....:53971", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:53971"], "connectionType": "udp"} 2025-05-21T15:04:34.325Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "309.664µs", "status": "200"} 2025-05-21T15:04:34.325Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_iEaKFRBZGSuv", "webhookTime": 1747839874, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "36.285µs", "sendDuration": "5.707242ms"} 2025-05-21T15:04:34.327Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_iEaKFRBZGSuv", "webhookTime": 1747839874, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "88.998µs", "sendDuration": "8.119617ms"} 2025-05-21T15:04:34.337Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:04:34.337Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:04:41.594Z INFO openvidu.transport rtc/transport.go:564 ice reconnected or switched pair {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "PUBLISHER", "existingPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 59431, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "93.91.143....", "remotePort": 53975}, "newPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 55936, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "***.***.***.***", "remotePort": 46777}} 2025-05-21T15:04:41.594Z INFO openvidu.transport rtc/transport.go:564 ice reconnected or switched pair {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "transport": "SUBSCRIBER", "existingPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 50649, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "93.91.143....", "remotePort": 53971}, "newPair": {"localProtocol": "udp", "localCandidateType": "host", "localAdddress": "***.***.***.***", "localPort": 53327, "remoteProtocol": "udp", "remoteCandidateType": "prflx", "remoteAdddress": "***.***.***.***", "remotePort": 49948}} 2025-05-21T15:09:16.540Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-21T15:09:16.545Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "172.496µs", "status": "200"} 2025-05-21T15:09:16.546Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_2y5T2yPYwCSP", "webhookTime": 1747840156, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "316.109µs", "sendDuration": "5.198357ms"} 2025-05-21T15:09:16.548Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_2y5T2yPYwCSP", "webhookTime": 1747840156, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_t7TgGZTLSi8k", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "112.889µs", "sendDuration": "7.401639ms"} 2025-05-21T15:09:20.260Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc004580320].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc004580be0].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-21T15:09:20.265Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "F92Rh1UYB5mRzgEVfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "fM6N7FzOGl7VfaMgFVyhO6RLbMIDDgeUwnQtRs0VKNDA"} 2025-05-21T15:09:20.679Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:09:20.680Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "transport": "SUBSCRIBER"} 2025-05-21T15:09:20.680Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:54406 (resolved: ***.***.***.***:54406)", "[local] tcp4 host ***.***.***.***:58991 (resolved: ***.***.***.***:58991)", "[local][selected:1] udp4 host ***.***.***.***:58248 (resolved: ***.***.***.***:58248)", "[local] tcp4 host ***.***.***.***:56687 (resolved: ***.***.***.***:56687)", "[local] udp4 host ***.***.***.***:54091 (resolved: ***.***.***.***:54091)", "[local] tcp4 host ***.***.***.***:58047 (resolved: ***.***.***.***:58047)", "[remote][trickle] udp4 host ***.***.***.***:61648", "[remote][trickle] udp4 host ***.***.***.***:61649", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:61650", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:61651", "[remote][trickle] udp4 srflx 93.91.143....:61649 related ***.***.***.***:61649", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][trickle] udp4 relay 15.161.237....:44694 related 93.91.143....:61649", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:61649"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:52089 (resolved: ***.***.***.***:52089)", "[local] tcp4 host ***.***.***.***:54197 (resolved: ***.***.***.***:54197)", "[local][selected:1] udp4 host ***.***.***.***:53222 (resolved: ***.***.***.***:53222)", "[local] tcp4 host ***.***.***.***:55228 (resolved: ***.***.***.***:55228)", "[local] udp4 host ***.***.***.***:57782 (resolved: ***.***.***.***:57782)", "[local] tcp4 host ***.***.***.***:51204 (resolved: ***.***.***.***:51204)", "[remote][trickle] udp4 host ***.***.***.***:61644", "[remote][trickle] udp4 host ***.***.***.***:61645", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:61646", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:61647", "[remote][trickle] udp4 srflx 93.91.143....:61645 related ***.***.***.***:61645", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:356d:dceb:f967:f710:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][trickle] udp4 relay 15.161.237....:49825 related 93.91.143....:61645", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:61645"], "connectionType": "udp"} 2025-05-21T15:09:20.684Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_pHDVG5MAJtGd", "webhookTime": 1747840160, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "25.597µs", "sendDuration": "4.120819ms"} 2025-05-21T15:09:20.686Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "216.948µs", "status": "200"} 2025-05-21T15:09:20.688Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_pHDVG5MAJtGd", "webhookTime": 1747840160, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "59.981µs", "sendDuration": "7.369214ms"} 2025-05-21T15:09:20.714Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:09:20.714Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "transport": "PUBLISHER"} 2025-05-21T15:11:01.383Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-21T15:11:01.387Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_qgefVGLot998", "webhookTime": 1747840261, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "111.132µs", "sendDuration": "3.595447ms"} 2025-05-21T15:11:01.389Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "227.033µs", "status": "200"} 2025-05-21T15:11:01.390Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_qgefVGLot998", "webhookTime": 1747840261, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "Matteo Resconi", "pID": "PA_TH3FnAaMaGoE", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "99.486µs", "sendDuration": "6.591004ms"} 2025-05-21T15:11:21.258Z INFO openvidu.room rtc/room.go:976 closing room {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv"} 2025-05-21T15:11:21.258Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "EG_ex2EbKhAA9SQ", "pID": "PA_dbWeQsaLAQiC", "remote": false, "sendLeave": true, "reason": "ROOM_CLOSED", "isExpectedToResume": false} 2025-05-21 15:11:21.259 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:199 > Worker::HandleRequest() | throwing MediaSoupError: Channel request handler with ID 074343d1-fcd7-4d97-945f-43356dddcdf4 not found logger=Channel pid=468 2025-05-21 15:11:21.26 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:199 > Worker::HandleRequest() | throwing MediaSoupError: Channel request handler with ID 074343d1-fcd7-4d97-945f-43356dddcdf4 not found [method:router.closeTransport] logger=Channel pid=468 2025-05-21 15:11:21.26 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:238 > request failed error="Channel request handler with ID 074343d1-fcd7-4d97-945f-43356dddcdf4 not found [method:router.closeTransport]" id=362 logger=Channel method=router.closeTransport 2025-05-21 15:11:21.26 ERR workspace/openvidupro/mediasoup/mediasoup-go/data_consumer.go:199 > dataConsumer close failed error="InvalidStateError:Channel closed, id: 363, method: transport.closeDataConsumer" logger=DataConsumer 2025-05-21 15:11:21.26 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:183 > read failed error="read |0: file already closed" logger=Channel 2025-05-21T15:11:21.260Z INFO openvidu service/roommanager.go:190 deleting room state {"room": "res-10"} 2025-05-21 15:11:21.26 ERR workspace/openvidupro/mediasoup/mediasoup-go/payload_channel.go:211 > read failed error="read |0: file already closed" logger=PayloadChannel 2025-05-21T15:11:21.260Z INFO openvidu.room service/roommanager.go:671 room closed {"room": "res-10", "roomID": "RM_XhNW6ouY68Yv"} 2025-05-21T15:11:21.264Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_3VAvVADpxUxR", "webhookTime": 1747840281, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "EG_ex2EbKhAA9SQ", "pID": "PA_dbWeQsaLAQiC", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "215.057µs", "sendDuration": "4.74939ms"} 2025-05-21T15:11:21.264Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "206.544µs", "status": "200"} 2025-05-21T15:11:21.268Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_3VAvVADpxUxR", "webhookTime": 1747840281, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "participant": "EG_ex2EbKhAA9SQ", "pID": "PA_dbWeQsaLAQiC", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "113.789µs", "sendDuration": "8.874619ms"} 2025-05-21T15:11:21.269Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_finished", "id": "EV_bzZxuMi5Exra", "webhookTime": 1747840281, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "3.598885ms", "sendDuration": "5.338204ms"} 2025-05-21T15:11:21.272Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "187.413µs", "status": "200"} 2025-05-21T15:11:21.274Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_finished", "id": "EV_bzZxuMi5Exra", "webhookTime": 1747840281, "room": "res-10", "roomID": "RM_XhNW6ouY68Yv", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "7.653928ms", "sendDuration": "6.752166ms"} 2025-05-21T15:11:21.324Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_ended", "id": "EV_rLXq9pupJHfe", "webhookTime": 1747840281, "egressID": "EG_ex2EbKhAA9SQ", "status": "EGRESS_ABORTED", "error": "Start signal not received", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "31.387µs", "sendDuration": "3.839864ms"} 2025-05-21T15:11:21.327Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "180.691µs", "status": "200"} 2025-05-21T15:11:21.330Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_ended", "id": "EV_rLXq9pupJHfe", "webhookTime": 1747840281, "egressID": "EG_ex2EbKhAA9SQ", "status": "EGRESS_ABORTED", "error": "Start signal not received", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "111.231µs", "sendDuration": "9.748663ms"} 2025-05-22T06:47:35.736Z INFO openvidu service/roomallocator.go:164 selected node for room {"room": "res-10", "selectedNodeID": "ND_eSypzSqkVU63"} 2025-05-22 06:47:35.759 INF workspace/openvidupro/mediasoup/mediasouproom/worker.go:176 > [getOrNewWorkerRoundRobin] mediasoup worker created PID=472 logger=mediasouproom 2025-05-22T06:47:35.761Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 0, "participantInit": {"Identity": "Matteo Resconi", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.12.0", "protocol": 16, "os": "Windows", "osVersion": "10", "deviceModel": "Other", "browser": "Edge", "browserVersion": "136.0.0"}, "Grants": {"Identity": "", "Kind": "", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": "not-set", "CanSubscribe": "not-set", "CanPublishData": "not-set", "CanPublishSources": [], "CanUpdateOwnMetadata": true, "IngressAdmin": false, "Hidden": false, "Recorder": false, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": true, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc0033ac320].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} 2025-05-22T06:47:35.764Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_started", "id": "EV_PFoVM53FXmpf", "webhookTime": 1747896455, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "17.843µs", "sendDuration": "3.277316ms"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc0033ad400].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-22T06:47:35.767Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "z1GOKp0cnJnN34UcfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "7KEKuXqtTL2ovFy0VnB908ddFlWb699breNsLMeTyT4"} 2025-05-22T06:47:35.770Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "3.259612ms", "status": "200"} 2025-05-22T06:47:35.772Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_started", "id": "EV_PFoVM53FXmpf", "webhookTime": 1747896455, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "110.632µs", "sendDuration": "11.600391ms"} 2025-05-22T06:47:36.128Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "transport": "SUBSCRIBER"} 2025-05-22T06:47:36.129Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "transport": "SUBSCRIBER"} 2025-05-22T06:47:36.129Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "transport": "PUBLISHER"} 2025-05-22T06:47:36.129Z WARN openvidu.transport.pion.ortc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "transport": "PUBLISHER"} 2025-05-22T06:47:36.129Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "publisherCandidates": ["[local] udp4 host ***.***.***.***:51464 (resolved: ***.***.***.***:51464)", "[local] tcp4 host ***.***.***.***:55513 (resolved: ***.***.***.***:55513)", "[local][selected:1] udp4 host ***.***.***.***:52245 (resolved: ***.***.***.***:52245)", "[local] tcp4 host ***.***.***.***:54622 (resolved: ***.***.***.***:54622)", "[local] udp4 host ***.***.***.***:58064 (resolved: ***.***.***.***:58064)", "[local] tcp4 host ***.***.***.***:51421 (resolved: ***.***.***.***:51421)", "[remote][trickle] udp4 host ***.***.***.***:61930", "[remote][trickle] udp4 host ***.***.***.***:61931", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:397a:95dc:8ef2:94ab:61932", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:61933", "[remote][trickle] udp4 srflx 93.91.143....:61931 related ***.***.***.***:61931", "[remote][trickle] udp4 relay 15.161.237....:43584 related 93.91.143....:61931", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:397a:95dc:8ef2:94ab:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:61931"], "subscriberCandidates": ["[local] udp4 host ***.***.***.***:52476 (resolved: ***.***.***.***:52476)", "[local] tcp4 host ***.***.***.***:54601 (resolved: ***.***.***.***:54601)", "[local][selected:1] udp4 host ***.***.***.***:55927 (resolved: ***.***.***.***:55927)", "[local] tcp4 host ***.***.***.***:59953 (resolved: ***.***.***.***:59953)", "[local] udp4 host ***.***.***.***:52903 (resolved: ***.***.***.***:52903)", "[local] tcp4 host ***.***.***.***:50603 (resolved: ***.***.***.***:50603)", "[remote][trickle] udp4 host ***.***.***.***:61926", "[remote][trickle] udp4 host ***.***.***.***:61927", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:397a:95dc:8ef2:94ab:61928", "[remote][trickle] udp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:61929", "[remote][trickle] udp4 srflx 93.91.143....:61927 related ***.***.***.***:61927", "[remote][trickle] udp4 relay 15.161.237....:44793 related 93.91.143....:61927", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp4 host ***.***.***.***:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:397a:95dc:8ef2:94ab:9", "[remote][trickle] tcp6 host fd0d:abb2:76c5:6040:4c36:e5f6:15c:ef89:9", "[remote][selected:1][trickle] udp4 prflx 93.91.143....:61927"], "connectionType": "udp"} 2025-05-22T06:47:36.135Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_xNxrkENBT8pT", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "113.803µs", "sendDuration": "5.300208ms"} 2025-05-22T06:47:36.136Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "219.181µs", "status": "200"} 2025-05-22T06:47:36.139Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_xNxrkENBT8pT", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "103.26µs", "sendDuration": "9.350095ms"} ### mediasoup Producer created {kind: "audio", type: "simple", paused: false} ### mediasoup Producer created {kind: "video", type: "simulcast", paused: false} 2025-05-22T06:47:36.222Z INFO openvidu.pub rtc/participant.go:1809 mediaTrack published {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "kind": "audio", "trackID": "TR_AM8ryjNeo5iwG3", "webrtcTrackID": "2c4af416-1b39-46fa-8ce4-d76bc0397bdf", "rid": "", "SSRC": 1766483935, "mime": "audio/opus", "trackInfo": {"sid": "TR_AM8ryjNeo5iwG3", "type": "AUDIO", "source": "MICROPHONE", "mimeType": "audio/opus", "mid": "1", "encryption": "NONE", "stream": "camera", "version": {"unixMicro": 1747896456221822}}, "fromSdp": true} 2025-05-22T06:47:36.227Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_published", "id": "EV_FiTuz9Mejonf", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "72.313µs", "sendDuration": "5.172604ms"} 2025-05-22T06:47:36.229Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "195.906µs", "status": "200"} 2025-05-22T06:47:36.232Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_published", "id": "EV_FiTuz9Mejonf", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "82.974µs", "sendDuration": "9.228466ms"} 2025-05-22T06:47:36.537Z INFO openvidu.pub rtc/participant.go:1809 mediaTrack published {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "kind": "video", "trackID": "TR_VC2rJjwaqMJcHB", "webrtcTrackID": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "rid": "q", "SSRC": 985541753, "mime": "video/VP8", "trackInfo": {"sid": "TR_VC2rJjwaqMJcHB", "type": "VIDEO", "width": 1280, "height": 720, "simulcast": true, "source": "CAMERA", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000}], "mimeType": "video/VP8", "mid": "2", "codecs": [{"mimeType": "video/VP8", "mid": "2", "cid": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000}]}], "encryption": "NONE", "stream": "camera", "version": {"unixMicro": 1747896456536961}}, "fromSdp": false} 2025-05-22T06:47:36.542Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_published", "id": "EV_KtexhnyWUTam", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "211.989µs", "sendDuration": "4.187745ms"} 2025-05-22T06:47:36.543Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "188.175µs", "status": "200"} 2025-05-22T06:47:36.545Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_published", "id": "EV_KtexhnyWUTam", "webhookTime": 1747896456, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "78.777µs", "sendDuration": "8.205234ms"} 2025-05-22T06:47:36.656Z INFO openvidu.pub rtc/participant.go:1809 mediaTrack published {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "kind": "video", "trackID": "TR_VC2rJjwaqMJcHB", "webrtcTrackID": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "rid": "h", "SSRC": 3913860700, "mime": "video/VP8", "trackInfo": {"sid": "TR_VC2rJjwaqMJcHB", "type": "VIDEO", "width": 1280, "height": 720, "simulcast": true, "source": "CAMERA", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000, "ssrc": 3913860700}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000}], "mimeType": "video/VP8", "mid": "2", "codecs": [{"mimeType": "video/VP8", "mid": "2", "cid": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000, "ssrc": 3913860700}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000}]}], "encryption": "NONE", "stream": "camera", "version": {"unixMicro": 1747896456536961}}, "fromSdp": false} 2025-05-22T06:47:36.666Z INFO openvidu.pub rtc/participant.go:1809 mediaTrack published {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "kind": "video", "trackID": "TR_VC2rJjwaqMJcHB", "webrtcTrackID": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "rid": "f", "SSRC": 3382047011, "mime": "video/VP8", "trackInfo": {"sid": "TR_VC2rJjwaqMJcHB", "type": "VIDEO", "width": 1280, "height": 720, "simulcast": true, "source": "CAMERA", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000, "ssrc": 3913860700}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000, "ssrc": 3382047011}], "mimeType": "video/VP8", "mid": "2", "codecs": [{"mimeType": "video/VP8", "mid": "2", "cid": "d59df7c6-4805-49aa-b9c4-c9814deaf5dd", "layers": [{"quality": "LOW", "width": 320, "height": 180, "bitrate": 160000, "ssrc": 985541753}, {"quality": "MEDIUM", "width": 640, "height": 360, "bitrate": 450000, "ssrc": 3913860700}, {"quality": "HIGH", "width": 1280, "height": 720, "bitrate": 1700000, "ssrc": 3382047011}]}], "encryption": "NONE", "stream": "camera", "version": {"unixMicro": 1747896456536961}}, "fromSdp": false} 2025-05-22T06:48:12.254Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_started", "id": "EV_BNzjGGXERLv5", "webhookTime": 1747896492, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_STARTING", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "20.757µs", "sendDuration": "2.741101ms"} 2025-05-22T06:48:12.255Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "250.495µs", "status": "200"} 2025-05-22T06:48:12.257Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_started", "id": "EV_BNzjGGXERLv5", "webhookTime": 1747896492, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_STARTING", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "93.953µs", "sendDuration": "5.440639ms"} 2025-05-22T06:48:12.280Z INFO openvidu.api service/twirp.go:124 API Egress.StartRoomCompositeEgress {"service": "Egress", "method": "StartRoomCompositeEgress", "room": "res-10", "baseUrl": "", "outputType": "file", "egressID": "EG_YXn5m28K45YZ", "duration": "535.583144ms", "status": "200"} 2025-05-22T06:48:12.725Z INFO openvidu service/roommanager.go:427 starting RTC session {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "remote": false, "room": "res-10", "nodeID": "ND_eSypzSqkVU63", "numParticipants": 1, "participantInit": {"Identity": "EG_YXn5m28K45YZ", "Reconnect": false, "ReconnectReason": "RR_UNKNOWN", "AutoSubscribe": true, "Client": {"sdk": "JS", "version": "2.7.5", "protocol": 15, "os": "Linux", "deviceModel": "Other", "browser": "Chrome", "browserVersion": "125.0.0"}, "Grants": {"Identity": "", "Kind": "egress", "Video": {"RoomCreate": false, "RoomList": false, "RoomRecord": false, "RoomAdmin": false, "RoomJoin": true, "Room": "res-10", "CanPublish": false, "CanSubscribe": true, "CanPublishData": false, "CanPublishSources": [], "CanUpdateOwnMetadata": "not-set", "IngressAdmin": false, "Hidden": true, "Recorder": true, "Agent": false, "CanSubscribeMetrics": "not-set"}, "SIP": {}, "RoomConfig": {}, "RoomPreset": ""}, "Region": "", "AdaptiveStream": false, "ID": "", "SubscriberAllowPause": "not-set", "DisableICELite": false, "CreateRoom": {"name": "res-10"}}} ### MediaEngine[0xc004223540].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} ### MediaEngine[0xc004223cc0].RegisterHeaderExtension(): Disabling header extension not supported by mediasoup {uri: "https://aomediacodec.github.io/av1-rtp-spec/#dependency-descriptor-rtp-header-extension"} DEBUG [mediasoup] transport listen IPs: []mediasoup.TransportListenIp{mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}, mediasoup.TransportListenIp{Ip:"***.***.***.***", AnnouncedIp:"***.***.***.***"}} 2025-05-22T06:48:12.733Z INFO openvidu service/roommanager.go:1001 created TURN password {"username": "wN1SMd3SqhFcGF2NfKIo4zu6gLK1gLMtghsgmJJoCC", "password": "GOtWniJtqGn4edXEss6A37p9LAPq4uqxNQUfxJXdaKq"} 2025-05-22T06:48:12.761Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "remote": false, "transport": "SUBSCRIBER"} 2025-05-22T06:48:12.762Z WARN openvidu.transport.pion.pc webrtc/datachannel.go:224 webrtc.DetachDataChannels() enabled but didn't Detach, call Detach from OnOpen {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "remote": false, "transport": "SUBSCRIBER"} 2025-05-22T06:48:12.762Z INFO openvidu rtc/room.go:534 participant active {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "remote": false, "subscriberCandidates": ["[local][selected:1] udp4 host ***.***.***.***:54207 (resolved: ***.***.***.***:54207)", "[local] tcp4 host ***.***.***.***:59923 (resolved: ***.***.***.***:59923)", "[local] udp4 host ***.***.***.***:58643 (resolved: ***.***.***.***:58643)", "[local] tcp4 host ***.***.***.***:50856 (resolved: ***.***.***.***:50856)", "[local] udp4 host ***.***.***.***:57830 (resolved: ***.***.***.***:57830)", "[local] tcp4 host ***.***.***.***:57116 (resolved: ***.***.***.***:57116)", "[remote][selected:1][trickle] udp4 prflx ***.***.***.***:57965", "[remote][filtered][trickle] udp4 host :57965", "[remote][trickle] udp4 srflx 15.161.237....:57965 related ***.***.***.***:0"], "connectionType": "udp"} 2025-05-22T06:48:12.767Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_gyBpphnK3GtA", "webhookTime": 1747896492, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "35.204µs", "sendDuration": "4.84645ms"} 2025-05-22T06:48:12.768Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "253.052µs", "status": "200"} 2025-05-22T06:48:12.770Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_joined", "id": "EV_gyBpphnK3GtA", "webhookTime": 1747896492, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "90.197µs", "sendDuration": "7.671562ms"} ### mediasoup Consumer created {kind: "audio", type: "simple", paused: true, preferredLayers: , trackId: "TR_AM8ryjNeo5iwG3"} ### mediasoup Consumer created {kind: "video", type: "simulcast", paused: true, preferredLayers: , trackId: "TR_VC2rJjwaqMJcHB"} 2025-05-22T06:48:14.947Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "279.243µs", "status": "200"} 2025-05-22T06:48:14.947Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_updated", "id": "EV_3e9dmnahh5Tx", "webhookTime": 1747896494, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_ACTIVE", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "141.377µs", "sendDuration": "6.401114ms"} 2025-05-22T06:48:14.949Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_updated", "id": "EV_3e9dmnahh5Tx", "webhookTime": 1747896494, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_ACTIVE", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "502.878µs", "sendDuration": "8.093353ms"} 2025-05-22T06:50:36.433Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "remote": false, "sendLeave": true, "reason": "CLIENT_REQUEST_LEAVE", "isExpectedToResume": false} 2025-05-22T06:50:36.438Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_unpublished", "id": "EV_NoZAtwhJkTTE", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "217.037µs", "sendDuration": "4.838698ms"} 2025-05-22T06:50:36.440Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "254.323µs", "status": "200"} 2025-05-22T06:50:36.441Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_unpublished", "id": "EV_5JtEtsQ38QQw", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "5.03821ms", "sendDuration": "2.644455ms"} 2025-05-22T06:50:36.442Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_unpublished", "id": "EV_NoZAtwhJkTTE", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "260.051µs", "sendDuration": "8.227772ms"} 2025-05-22T06:50:36.445Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "271.404µs", "status": "200"} 2025-05-22T06:50:36.445Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_5wqJcart58dh", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "6.752774ms", "sendDuration": "4.189588ms"} 2025-05-22T06:50:36.447Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "track_unpublished", "id": "EV_5JtEtsQ38QQw", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "8.468164ms", "sendDuration": "5.219024ms"} 2025-05-22T06:50:36.452Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "283.833µs", "status": "200"} 2025-05-22T06:50:36.455Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_5wqJcart58dh", "webhookTime": 1747896636, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "Matteo Resconi", "pID": "PA_qN76rgsJJ8ms", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "12.759211ms", "sendDuration": "8.134761ms"} 2025-05-22T06:50:56.257Z INFO openvidu.room rtc/room.go:976 closing room {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF"} 2025-05-22T06:50:56.257Z INFO openvidu rtc/participant.go:1047 participant closing {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "remote": false, "sendLeave": true, "reason": "ROOM_CLOSED", "isExpectedToResume": false} 2025-05-22 06:50:56.259 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:199 > Worker::HandleRequest() | throwing MediaSoupError: Channel request handler with ID a4cf35a2-7d15-4bc8-88e1-0d78524afd18 not found logger=Channel pid=472 2025-05-22 06:50:56.259 ERR workspace/openvidupro/mediasoup/mediasoup-go/payload_channel.go:211 > read failed error="read |0: file already closed" logger=PayloadChannel 2025-05-22T06:50:56.260Z INFO openvidu service/roommanager.go:190 deleting room state {"room": "res-10"} 2025-05-22 06:50:56.259 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:199 > Worker::HandleRequest() | throwing MediaSoupError: Channel request handler with ID a4cf35a2-7d15-4bc8-88e1-0d78524afd18 not found [method:router.closeTransport] logger=Channel pid=472 2025-05-22 06:50:56.261 ERR workspace/openvidupro/mediasoup/mediasoup-go/channel.go:183 > read failed error="read |0: file already closed" logger=Channel 2025-05-22T06:50:56.261Z INFO openvidu.room service/roommanager.go:671 room closed {"room": "res-10", "roomID": "RM_o6zwS6vNMgsF"} 2025-05-22T06:50:56.262Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "167.519µs", "status": "200"} 2025-05-22T06:50:56.263Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_LyeXQcoHZXNo", "webhookTime": 1747896656, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "87.109µs", "sendDuration": "5.25467ms"} 2025-05-22T06:50:56.265Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "participant_left", "id": "EV_LyeXQcoHZXNo", "webhookTime": 1747896656, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "participant": "EG_YXn5m28K45YZ", "pID": "PA_7aFpXjKwLKSp", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "82.089µs", "sendDuration": "7.476363ms"} 2025-05-22T06:50:56.266Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_finished", "id": "EV_oNKbXVyshdA3", "webhookTime": 1747896656, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "2.465045ms", "sendDuration": "3.2518ms"} 2025-05-22T06:50:56.269Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_updated", "id": "EV_Th8LLfNRsmYe", "webhookTime": 1747896656, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_ENDING", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "89.651µs", "sendDuration": "2.701781ms"} 2025-05-22T06:50:56.269Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "307.569µs", "status": "200"} 2025-05-22T06:50:56.272Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "room_finished", "id": "EV_oNKbXVyshdA3", "webhookTime": 1747896656, "room": "res-10", "roomID": "RM_o6zwS6vNMgsF", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "4.753243ms", "sendDuration": "6.942255ms"} 2025-05-22T06:50:56.273Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "463.214µs", "status": "200"} 2025-05-22T06:50:56.275Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_updated", "id": "EV_Th8LLfNRsmYe", "webhookTime": 1747896656, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_ENDING", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "241.79µs", "sendDuration": "7.786248ms"} 2025-05-22T06:51:11.816Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_ended", "id": "EV_8gxDXeVXLgTH", "webhookTime": 1747896671, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_COMPLETE", "url": "http://***.***.***.***:4443/livekit/webhook", "queueDuration": "36.445µs", "sendDuration": "5.074622ms"} 2025-05-22T06:51:11.816Z INFO openvidu.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["res-10"], "duration": "158.019µs", "status": "200"} 2025-05-22T06:51:11.819Z INFO openvidu.webhook webhook/url_notifier.go:124 sent webhook {"event": "egress_ended", "id": "EV_8gxDXeVXLgTH", "webhookTime": 1747896671, "egressID": "EG_YXn5m28K45YZ", "status": "EGRESS_COMPLETE", "url": "http://***.***.***.***:6080/livekit/webhook", "queueDuration": "83.483µs", "sendDuration": "8.475753ms"}