Hi,
I locally deployed OV3, integrated it in my application, videocalls are working fine, but when i trying to record the room, using RoomComposite Egress. Something stopping it, its getting aborted everytime. here are the docker logs
egress | 2024-10-14T05:31:51.748Z INFO egress service/service_rpc.go:45 request received {"nodeID": "NE_V4Ms7vbiZBSZ", "clusterID": "", "egressID": "EG_eZRQ996m6uby"}
egress | 2024-10-14T05:31:51.749Z INFO egress service/service_rpc.go:60 request validated {"nodeID": "NE_V4Ms7vbiZBSZ", "clusterID": "", "egressID": "EG_eZRQ996m6uby", "requestType": "room_composite", "outputType": "file", "room": "da1622cb-a98c-4159-921f-df3115fcf90f", "request": {"RoomComposite":{"room_name":"da1622cb-a98c-4159-921f-df3115fcf90f","layout":"speaker","Output":{"File":{"file_type":1,"filepath":"sdf12.mp4","Output":{"S3":{"access_key":"{access_key}","secret":"{secret}","region":"us-east-1","endpoint":"http://minio:9000","bucket":"openvidu","force_path_style":true}}}},"Options":null}}}
openvidu | 2024-10-14T05:31:51.756Z INFO livekit.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["da1622cb-a98c-4159-921f-df3115fcf90f"], "duration": "390.156µs", "status": "200"}
openvidu | 2024-10-14T05:31:51.759Z INFO livekit.webhook webhook/url_notifier.go:88 sent webhook {"url": "http://default-app:6080/livekit/webhook", "event": "egress_started", "eventDetails": {"event": "egress_started", "egressInfo": {"egressId": "EG_eZRQ996m6uby", "roomId": "RM_FKKYrp6SCawq", "roomName": "da1622cb-a98c-4159-921f-df3115fcf90f", "updatedAt": 1728883911748519648, "roomComposite": {"roomName": "da1622cb-a98c-4159-921f-df3115fcf90f", "layout": "speaker", "file": {"fileType": 1, "filepath": "sdf12.mp4", "s3": {"accessKey": "{access_key}", "secret": "{secret}", "region": "us-east-1", "endpoint": "http://minio:9000", "bucket": "openvidu", "forcePathStyle": true}}}, "file": {"filename": "sdf12.mp4"}, "fileResults": [{"filename": "sdf12.mp4"}]}, "id": "EV_ZQYoXfGJmd5b", "createdAt": 1728883911}}
egress | 2024-10-14T05:31:51.781Z INFO egress redis/redis.go:142 connecting to redis {"nodeID": "NE_V4Ms7vbiZBSZ", "handlerID": "EGH_WFCmoEDwayHj", "clusterID": "", "egressID": "EG_eZRQ996m6uby", "simple": true, "addr": "redis:6379"}
openvidu | 2024-10-14T05:31:51.783Z INFO livekit.api service/twirp.go:124 API Egress.StartRoomCompositeEgress {"service": "Egress", "method": "StartRoomCompositeEgress", "room": "da1622cb-a98c-4159-921f-df3115fcf90f", "baseUrl": "", "outputType": "file", "egressID": "EG_eZRQ996m6uby", "duration": "536.898718ms", "status": "200"}
openvidu | 2024-10-14T05:31:52.281Z INFO livekit service/roommanager.go:813 created TURN password {"username": "HlVVopHV6hmUDplTfKIo4LvyWzuyID", "password": "K2jVIYozYyRE0luHunC0hhiszJIJ3W0gRMWyfJgs3qZ"}
openvidu | 2024-10-14T05:31:52.282Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:274 signaling state changed to have-local-offer {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.304Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:274 signaling state changed to stable {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.304Z INFO livekit.transport.pion.ice v2@v2.3.14/agent.go:504 Setting new connection state: Checking {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.304Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:484 ICE connection state changed: checking {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.304Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.304Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:498 peer connection state changed: connecting {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.336Z WARN livekit.webhook webhook/url_notifier.go:85 failed to send webhook {"url": "http://host.docker.internal:6080/livekit/webhook", "event": "participant_joined", "error": "POST http://host.docker.internal:6080/livekit/webhook giving up after 5 attempt(s): Post \"http://host.docker.internal:6080/livekit/webhook\": dial tcp 172.17.0.1:6080: i/o timeout"}
openvidu | 2024-10-14T05:31:52.432Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:274 signaling state changed to have-local-offer {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.445Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:274 signaling state changed to stable {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.445Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:674 Remote mDNS candidate added, but mDNS is disabled: (84c7f36c-19d6-4a54-9cdf-02d7d994f845.local) {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.504Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.705Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:52.905Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:53.106Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:53.307Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:53.507Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:53.708Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:53.909Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:54.109Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:54.310Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:54.511Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:31:54.712Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:05.550Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:05.750Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:05.951Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:06.152Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:06.353Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:06.554Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:06.754Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:06.955Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.156Z WARN livekit.transport.pion.ice v2@v2.3.14/agent.go:545 Failed to ping without candidate pairs. Connection is not possible yet.{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.296Z INFO livekit rtc/participant.go:811 participant closing {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "sendLeave": false, "reason": "SIGNAL_SOURCE_CLOSE", "isExpectedToResume": false}
openvidu | 2024-10-14T05:32:07.297Z INFO livekit rtc/room.go:583 removing participant without connection {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "subscriberCandidates": ["[local] udp4 host 192.168.75.28:7952", "[local] tcp4 host 192.168.75.28:7881"], "connectionType": "unknown", "reason": "NONE"}
openvidu | 2024-10-14T05:32:07.297Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:498 peer connection state changed: closed {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "PUBLISHER"}
openvidu | 2024-10-14T05:32:07.297Z INFO livekit.transport.pion.ice v2@v2.3.14/agent.go:504 Setting new connection state: Closed {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:498 peer connection state changed: closed {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z WARN livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:2266 Failed to start manager: connecting canceled by caller{"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z WARN livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:1474 Failed to start SCTP: DTLS not established {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z INFO livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:484 ICE connection state changed: closed {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z WARN livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:1652 undeclaredMediaProcessor failed to open SrtpSession: the DTLS transport has not started yet {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
openvidu | 2024-10-14T05:32:07.297Z WARN livekit.transport.pion.pc v3@v3.2.34/peerconnection.go:1696 undeclaredMediaProcessor failed to open SrtcpSession: the DTLS transport has not started yet {"room": "da1622cb-a98c-4159-921f-df3115fcf90f", "roomID": "RM_FKKYrp6SCawq", "participant": "EG_eZRQ996m6uby", "pID": "PA_NZCRhzTzhUYG", "remote": false, "transport": "SUBSCRIBER"}
egress | 2024-10-14T05:32:07.298Z INFO egress source/web.go:285 chrome: END_RECORDING {"nodeID": "NE_V4Ms7vbiZBSZ", "handlerID": "EGH_WFCmoEDwayHj", "clusterID": "", "egressID": "EG_eZRQ996m6uby"}
openvidu | 2024-10-14T05:32:07.348Z INFO livekit.api service/twirp.go:124 API RoomService.ListRooms {"service": "RoomService", "method": "ListRooms", "room": ["da1622cb-a98c-4159-921f-df3115fcf90f"], "duration": "184.147µs", "status": "200"}
openvidu | 2024-10-14T05:32:07.350Z INFO livekit.webhook webhook/url_notifier.go:88 sent webhook {"url": "http://default-app:6080/livekit/webhook", "event": "egress_ended", "eventDetails": {"event": "egress_ended", "egressInfo": {"egressId": "EG_eZRQ996m6uby", "roomId": "RM_FKKYrp6SCawq", "roomName": "da1622cb-a98c-4159-921f-df3115fcf90f", "status": 5, "startedAt": 1728883912269423178, "endedAt": 1728883927342325556, "updatedAt": 1728883927342325556, "details": "Stop called before pipeline could start", "roomComposite": {"roomName": "da1622cb-a98c-4159-921f-df3115fcf90f", "layout": "speaker", "file": {"fileType": 1, "filepath": "sdf12.mp4", "s3": {"accessKey": "{access_key}", "secret": "{secret}", "region": "us-east-1", "endpoint": "http://minio:9000", "bucket": "openvidu", "forcePathStyle": true}}}, "file": {"filename": "sdf12.mp4", "startedAt": 1728883927298699561, "endedAt": 1728883927299145226, "duration": 445665}, "fileResults": [{"filename": "sdf12.mp4", "startedAt": 1728883927298699561, "endedAt": 1728883927299145226, "duration": 445665}]}, "id": "EV_7VcBZGb9L3pX", "createdAt": 1728883927}}
openvidu | 2024-10-14T05:32:07.351Z INFO livekit service/ioservice.go:159 received egress metrics {"egressID": "EG_eZRQ996m6uby", "avgCpu": 0.13944203, "maxCpu": 1.0317196}