When screen sharing encounters network fluctuations, it will automatically disconnect

Describe the bug
When screen sharing encounters network fluctuations, it will automatically disconnect
Server

Version: 1.4.4
Environment: local dev

Client

SDK: js
Version: 1.12.1

To Reproduce
Steps to reproduce the behavior:

two clients are connected to room
screen sharing
etwork fluctuation
screen sharing disconnect

Expected behavior
When screen sharing encounters network fluctuations, do not close the connection, or restore it later
Additional context
The client closed the simulcast, because enabled simulcasteven in the Intranet environment can not get better picture quality

@toskeyfine Can you please provide more details (screen shots or video would be great too)?

By disconnect, do you mean the client is completely disconnecting or losing video only?
Do you have server logs of the session where this happens and can you share that? Please add description of which user is sharing screen and which user disconnects

@boks1971

@boks1971

losing video only.
Because of the random nature of network fluctuations, I can't provide an accurate log for the time being
The receiver disconnects, but the screen sharing sender continues to send

2023-08-04T10:12:24.786+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": true}
2023-08-04T10:12:25.158+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: -1, t: -1}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:12:25.158+0800    INFO    livekit sfu/forwarder.go:1481   starting forwarding     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "sequenceNumber": 31996, "timestamp":<PHONE_NUMBER>, "layer": 0, "referenceLayerSpatial": 0}
2023-08-04T10:12:25.171+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:12:25.172+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:12:25.845677 +0000 UTC", "refNTP": "2023-08-04 02:12:25.575628 +0000 UTC", "ntpDiff": "-270.049ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -24304, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:12:25.172+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:12:25.172055283 +0800 CST m=+602519.266608755", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>3709551615, "nextTS":<PHONE_NUMBER>, "jump": 88, "explanation": "l < r < e, 4, 1683"}
2023-08-04T10:12:25.192+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 1, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:12:25.192+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:12:25.192+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:12:25.168974 +0000 UTC", "refNTP": "2023-08-04 02:12:25.575628 +0000 UTC", "ntpDiff": "406.654ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": 36598, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:12:25.192+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:12:25.192381977 +0800 CST m=+602519.286935428", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>3709551615, "nextTS":<PHONE_NUMBER>, "jump": 1714, "explanation": "r < l < e, 56, 3428"}
2023-08-04T10:12:26.068+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": false}
2023-08-04T10:12:30.740+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": false}
2023-08-04T10:12:31.786+0800    WARN    livekit connectionquality/scorer.go:257 error getting expected distance {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "error": "anachronous sample"}
2023-08-04T10:12:46.866+0800    INFO    livekit connectionquality/scorer.go:313 quality drop    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "down", "reason": "packet", "prevScore": 100, "prevQuality": "EXCELLENT", "prevStat": "start: 2023-08-04 10:12:34.861676227 +0800 CST m=+602528.956229725, dur: 4.656939317s, pe: 22, pl: 0, pm: 0, pooo: 0, b: 396, rtt: 6, jitter: 0.00", "score": 62.648087197696, "quality": "GOOD", "stat": "start: 2023-08-04 10:12:39.518615527 +0800 CST m=+602533.613169042, dur: 7.058333839s, pe: 34, pl: 4, pm: 0, pooo: 0, b: 612, rtt: 6, jitter: 0.00", "packetLossWeight": 4.535589411708344, "maxPPS": 5.223471376770053, "expectedBitrate": 0, "expectedDistance": 0}
2023-08-04T10:12:47.986+0800    INFO    livekit connectionquality/scorer.go:313 quality drop    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "down", "reason": "packet", "prevScore": 96.0118026346372, "prevQuality": "EXCELLENT", "prevStat": "start: 2023-08-04 10:12:33.816268949 +0800 CST m=+602527.910822394, dur: 8.736446387s, pe: 293, pl: 7, pm: 0, pooo: 0, b: 21370, rtt: 10, jitter: 0.00", "score": 75.69265516231445, "quality": "GOOD", "stat": "start: 2023-08-04 10:12:42.552715281 +0800 CST m=+602536.647268781, dur: 4.319461425s, pe: 171, pl: 17, pm: 0, pooo: 0, b: 12253, rtt: 5, jitter: 5828.27", "packetLossWeight": 3.3209760020177446, "maxPPS": 50.16871828969842, "expectedBitrate": 0, "expectedDistance": 0}
2023-08-04T10:12:51.786+0800    WARN    livekit connectionquality/scorer.go:257 error getting expected distance {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "error": "anachronous sample"}
2023-08-04T10:13:22.266+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": true}
2023-08-04T10:13:22.614+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: -1, t: -1}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:13:22.614+0800    INFO    livekit sfu/forwarder.go:1481   starting forwarding     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "sequenceNumber": 32105, "timestamp":<PHONE_NUMBER>, "layer": 0, "referenceLayerSpatial": 0}
2023-08-04T10:13:22.634+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:13:22.634+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:13:23.063283 +0000 UTC", "refNTP": "2023-08-04 02:13:23.371679 +0000 UTC", "ntpDiff": "308.396ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": 27755, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:13:22.634+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:13:22.634809692 +0800 CST m=+602576.729363164", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>3709551615, "nextTS":<PHONE_NUMBER>, "jump": 152, "explanation": "l < r < e, 55, 1946"}
2023-08-04T10:13:22.645+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 1, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:13:22.645+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:13:22.645+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:13:22.529027 +0000 UTC", "refNTP": "2023-08-04 02:13:23.371679 +0000 UTC", "ntpDiff": "842.652ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": 75838, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:13:22.645+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:13:22.645250218 +0800 CST m=+602576.739803681", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>3709551615, "nextTS":<PHONE_NUMBER>, "jump": 1394, "explanation": "r < l < e, 120, 2789"}
2023-08-04T10:13:51.786+0800    WARN    livekit connectionquality/scorer.go:257 error getting expected distance {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "error": "anachronous sample"}
2023-08-04T10:13:59.510+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": false}
2023-08-04T10:14:12.010+0800    INFO    livekit videolayerselector/simulcast.go:68      downgrading layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 0, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:12.011+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:12.011080152 +0800 CST m=+602626.105633651", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 337728, "explanation": "l < r < e, 337299, 8590"}
2023-08-04T10:14:12.011+0800    INFO    livekit videolayerselector/simulcast.go:68      downgrading layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 0, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:12.011+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:12.011320368 +0800 CST m=+602626.105873943", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 337714, "explanation": "l < r < e, 337284, 8611"}
2023-08-04T10:14:16.786+0800    INFO    livekit connectionquality/scorer.go:313 quality drop    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "reason": "layer", "prevScore": 99.99998003164114, "prevQuality": "EXCELLENT", "prevStat": "start: 2023-08-04 10:14:06.786968857 +0800 CST m=+602620.881522305, dur: 5.000260815s, pe: 257, pl: 0, pm: 0, pooo: 0, b: 99, rtt: 0, jitter: 11416.81", "score": 51.307945368958684, "quality": "GOOD", "stat": "start: 2023-08-04 10:14:11.787207209 +0800 CST m=+602625.881760702, dur: 4.999315171s, pe: 270, pl: 0, pm: 0, pooo: 0, b: 62486, rtt: 0, jitter: 12230.47", "packetLossWeight": 0.4465259477008039, "maxPPS":<PHONE_NUMBER>1728928, "expectedBitrate": 0, "expectedDistance": 1.9874305567564763}
2023-08-04T10:14:21.786+0800    INFO    livekit connectionquality/scorer.go:313 quality drop    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "reason": "layer", "prevScore": 51.307945368958684, "prevQuality": "GOOD", "prevStat": "start: 2023-08-04 10:14:11.787207209 +0800 CST m=+602625.881760702, dur: 4.999315171s, pe: 270, pl: 0, pm: 0, pooo: 0, b: 62486, rtt: 0, jitter: 12230.47", "score": 36.39238361068761, "quality": "POOR", "stat": "start: 2023-08-04 10:14:16.786495992 +0800 CST m=+602630.881049482, dur: 4.999988141s, pe: 252, pl: 0, pm: 0, pooo: 0, b: 55, rtt: 0, jitter: 12230.47", "packetLossWeight": 0.3888690141835055, "maxPPS":<PHONE_NUMBER>1728928, "expectedBitrate": 0, "expectedDistance": 2}
2023-08-04T10:14:31.815+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": true}
2023-08-04T10:14:31.980+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": true}
2023-08-04T10:14:32.179+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: -1, t: -1}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:32.179+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:32.179094513 +0800 CST m=+602646.273647971", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 11410051, "explanation": "l < r < e, 11401080, 9761"}
2023-08-04T10:14:32.179+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: -1, t: -1}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:32.179+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:32.179219272 +0800 CST m=+602646.273772730", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 2991730, "explanation": "l < r < e, 2991584, 2938"}
2023-08-04T10:14:33.190+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:33.785865 +0000 UTC", "refNTP": "2023-08-04 02:14:33.622582 +0000 UTC", "ntpDiff": "-163.283ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -14695, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:33.190318747 +0800 CST m=+602647.284872354", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 855, "explanation": "r < l < e, 8946, 1710"}
2023-08-04T10:14:33.190+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:33.785865 +0000 UTC", "refNTP": "2023-08-04 02:14:33.622582 +0000 UTC", "ntpDiff": "-163.283ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -14695, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:33.190+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:33.190416684 +0800 CST m=+602647.284970135", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 1855, "explanation": "r < l < e, 121, 3710"}
2023-08-04T10:14:34.217+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.217+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:34.965996 +0000 UTC", "refNTP": "2023-08-04 02:14:34.746441 +0000 UTC", "ntpDiff": "-219.555ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -19759, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:34.218+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:34.217991684 +0800 CST m=+602648.312545141", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 6326, "explanation": "r < l < e, 470, 12653"}
2023-08-04T10:14:34.218+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.218+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:34.965996 +0000 UTC", "refNTP": "2023-08-04 02:14:34.746441 +0000 UTC", "ntpDiff": "-219.555ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -19759, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:34.218+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:34.218104722 +0800 CST m=+602648.312658174", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 11987, "explanation": "r < l < e, 471, 12662"}
2023-08-04T10:14:34.224+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 1, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.224+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.224+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:34.903152 +0000 UTC", "refNTP": "2023-08-04 02:14:34.746441 +0000 UTC", "ntpDiff": "-156.711ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -14103, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:34.224+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:34.224860517 +0800 CST m=+602648.319413968", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 3472, "explanation": "r < l < e, 6782, 6945"}
2023-08-04T10:14:34.224+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 1, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.224+0800    INFO    livekit videolayerselector/simulcast.go:102     reached max layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 2, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:34.225+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:34.903152 +0000 UTC", "refNTP": "2023-08-04 02:14:34.746441 +0000 UTC", "ntpDiff": "-156.711ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -14103, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:34.225+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:34.225002209 +0800 CST m=+602648.319555658", "layer": 2, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 648, "explanation": "r < l < e, 12444, 1296"}
2023-08-04T10:14:34.962+0800    INFO    livekit buffer/rtpstats.go:928  sending sender report, time warp        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "ntp": "2023-08-04 02:14:34.962871537 +0000 UTC", "rtp":<PHONE_NUMBER>, "departure": "2023-08-04 10:14:34.962871537 +0800 CST m=+602649.057425095", "ntpDiffSinceLast": 3.000697491, "rtpDiffSinceLast": 251306, "departureDiffSinceLast": 3.000697491, "expectedTimeDiffSinceLast": 2.792288888888889, "packetDrift": "time: 2m52.219132287s, rtp: 15496756, driftSamples: -2965, driftMs: -32.94, sampleRate: 89982.78", "reportDrift": "time: 2m51.038366037s, rtp: 15393505, driftSamples: 53, driftMs: 0.59, sampleRate: 90000.30", "highestTS":<PHONE_NUMBER>, "highestTime": "2023-08-04 10:14:34.214767066 +0800 CST m=+602648.309320514"}
2023-08-04T10:14:38.794+0800    INFO    livekit rtc/subscribedtrack.go:182      updated subscribed track enabled        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "publisherID": "PA_UsusSAXGdz8n", "publisher": "9afd8fa9736ed8a0a876744ea2af8847", "enabled": false}
2023-08-04T10:14:40.001+0800    INFO    livekit videolayerselector/simulcast.go:68      downgrading layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 0, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:40.001+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:40.00129277 +0800 CST m=+602654.095846227", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 241395, "explanation": "l < r < e, 240333, 12659"}
2023-08-04T10:14:40.001+0800    INFO    livekit videolayerselector/simulcast.go:68      downgrading layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 0, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:40.001+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:40.001376271 +0800 CST m=+602654.095929721", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 241367, "explanation": "l < r < e, 240734, 12666"}
2023-08-04T10:14:40.001+0800    INFO    livekit videolayerselector/simulcast.go:68      downgrading layer       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 2, t: 0}", "target": "VideoLayer{s: 0, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 0, "req": 0, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed": 276984556}
2023-08-04T10:14:40.001+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:40.001440932 +0800 CST m=+602654.095994386", "layer": 0, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 238128, "explanation": "l < r < e, 237495, 12672"}
2023-08-04T10:14:41.787+0800    WARN    livekit connectionquality/scorer.go:257 error getting expected distance {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "direction": "up", "error": "anachronous sample"}
2023-08-04T10:14:43.937+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:44.684018 +0000 UTC", "refNTP": "2023-08-04 02:14:44.449703 +0000 UTC", "ntpDiff": "-234.315ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -21088, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:43.937094801 +0800 CST m=+602658.031648258", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 25814, "explanation": "r < l < e, 141254, 51629"}
2023-08-04T10:14:43.937+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:44.684018 +0000 UTC", "refNTP": "2023-08-04 02:14:44.449703 +0000 UTC", "ntpDiff": "-234.315ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -21088, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:43.937213737 +0800 CST m=+602658.031767195", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 26034, "explanation": "r < l < e, 140825, 52069"}
2023-08-04T10:14:43.937+0800    INFO    livekit videolayerselector/simulcast.go:54      upgrading layer {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "current": "VideoLayer{s: 0, t: 0}", "target": "VideoLayer{s: 2, t: 0}", "max": "VideoLayer{s: 2, t: 3}", "layer": 1, "req": 2, "maxSeen": "VideoLayer{s: 2, t: 0}", "feed":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/streamtrackermanager.go:578 getting reference timestamp     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "referenceLayer": 0, "incomingTS":<PHONE_NUMBER>, "layerNTP": "2023-08-04 02:14:44.684018 +0000 UTC", "refNTP": "2023-08-04 02:14:44.449703 +0000 UTC", "ntpDiff": "-234.315ms", "layerRTP":<PHONE_NUMBER>, "refRTP":<PHONE_NUMBER>, "rtpDiff": -21088, "normalizedTS":<PHONE_NUMBER>, "mappedTS":<PHONE_NUMBER>}
2023-08-04T10:14:43.937+0800    INFO    livekit sfu/forwarder.go:1544   next timestamp on switch        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "switchingAt": "2023-08-04 10:14:43.937291104 +0800 CST m=+602658.031844551", "layer": 1, "lastTS":<PHONE_NUMBER>, "refTS":<PHONE_NUMBER>, "refTSOffset": 0, "referenceLayerSpatial": 0, "expectedTS":<PHONE_NUMBER>, "minTS":<PHONE_NUMBER>, "nextTS":<PHONE_NUMBER>, "jump": 26038, "explanation": "r < l < e, 140825, 52076"}
2023-08-04T10:14:43.968+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 0, "direction": "upstream", "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:43 UTC 2023|182.18s, sn: 30538|33114, ep: 2577|14.15/s, p: 2577|14.15/s, l: 0|0.0/s|0.00%, b: 2811381|123453.8bps|52080, f: 302|1.7/s / 18|Fri Aug  4 02:14:43 UTC 2023, d: 7|0.04/s, bd: 6706|294.5bps|140, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 6, c: 90000, j: 8588(95428.6us)|8588(95428.6us), n:0|0|0|0, pli:3|Fri Aug  4 02:14:39 UTC 2023 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):0|0, drift(ms):-104.74, sr(Hz):89948.11"}
2023-08-04T10:14:43.968+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 1, "direction": "upstream", "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:43 UTC 2023|182.16s, sn: 12616|14225, ep: 1610|8.84/s, p: 1610|8.84/s, l: 0|0.0/s|0.00%, b: 1749165|76818.9bps|32640, f: 175|1.0/s / 8|Fri Aug  4 02:14:43 UTC 2023, d: 2|0.01/s, bd: 1233|54.2bps|40, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 1, c: 90000, j: 9198(102201.8us)|11215(124615.7us), n:0|0|0|0, pli:2|Fri Aug  4 02:14:41 UTC 2023 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):0|0, drift(ms):-2094.01, sr(Hz):88965.21"}
2023-08-04T10:14:43.968+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264", "layer": 2, "direction": "upstream", "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:43 UTC 2023|182.15s, sn: 3726|13414, ep: 9689|53.19/s, p: 1853|10.17/s, l: 0|0.0/s|0.00%, b: 2028615|89095.8bps|37260, f: 189|1.0/s / 9|Fri Aug  4 02:14:40 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 7836|43.02/s, bp: 2154900|94642.2bps|156720, o: 0, c: 90000, j: 9377(104198.0us)|11277(125303.8us), n:0|0|0|0, pli:11|Fri Aug  4 02:14:42 UTC 2023 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):0|0, drift(ms):-2240.23, sr(Hz):88892.90"}
2023-08-04T10:14:44.095+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "mime": "audio/opus", "layer": 0, "direction": "upstream", "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.40s, sn: 7780|8656, ep: 877|4.81/s, p: 877|4.81/s, l: 0|0.0/s|0.00%, b: 32761|1436.8bps|17540, f: 1|0.0/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 470(9794.8us)|891(18578.3us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):0|0, drift(ms):-7.73, sr(Hz):47997.96"}
2023-08-04T10:14:44.167+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "direction": "downstream", "mime": "video/h264", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:13:22 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|81.55s, sn: 32105|32569, ep: 465|5.70/s, p: 465|5.70/s, l: 0|0.0/s|0.00%, b: 497498|48802.5bps|9300, f: 49|0.6/s / 7|Fri Aug  4 02:14:34 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 90000, j: 4781(53122.2us)|5453(60588.9us), n:0|0|0|0, pli:2|Mon Jan  1 00:00:00 UTC 0001 / 3|Fri Aug  4 02:14:31 UTC 2023, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):23|42, drift(ms):35.37, sr(Hz):90039.03"}
2023-08-04T10:14:44.167+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "direction": "downstream", "mime": "video/h264", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.17s, sn: 30561|33396, ep: 2836|15.57/s, p: 2836|15.57/s, l: 0|0.0/s|0.00%, b: 3112477|136684.7bps|56720, f: 307|1.7/s / 22|Fri Aug  4 02:14:43 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 90000, j: 11437(127077.8us)|11627(129188.9us), n:0|0|0|0, pli:1|Fri Aug  4 02:14:11 UTC 2023 / 45|Fri Aug  4 02:14:44 UTC 2023, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):29|57, drift(ms):35.31, sr(Hz):90017.45"}
2023-08-04T10:14:44.167+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "direction": "downstream", "mime": "video/h264", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:12:25 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|139.01s, sn: 31996|32131, ep: 136|0.98/s, p: 136|0.98/s, l: 0|0.0/s|0.00%, b: 147802|8506.1bps|2720, f: 12|0.1/s / 3|Fri Aug  4 02:12:25 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 90000, j: 2508(27866.7us)|2948(32755.6us), n:0|0|0|0, pli:1|Mon Jan  1 00:00:00 UTC 0001 / 3|Fri Aug  4 02:12:25 UTC 2023, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):21|62, drift(ms):35.36, sr(Hz):90022.89"}
2023-08-04T10:14:44.167+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "direction": "downstream", "mime": "video/h264", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.17s, sn: 30561|33143, ep: 2583|14.18/s, p: 2583|14.18/s, l: 0|0.0/s|0.00%, b: 2946351|129389.0bps|51660, f: 187|1.0/s / 19|Fri Aug  4 02:14:43 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 90000, j: 11581(128677.8us)|11776(130844.4us), n:0|0|0|0, pli:1|Mon Jan  1 00:00:00 UTC 0001 / 43|Fri Aug  4 02:14:44 UTC 2023, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):9|49, drift(ms):35.36, sr(Hz):90017.47"}
2023-08-04T10:14:44.167+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "direction": "downstream", "mime": "video/h264", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.17s, sn: 30561|33396, ep: 2836|15.57/s, p: 2836|15.57/s, l: 0|0.0/s|0.00%, b: 3112477|136684.3bps|56720, f: 307|1.7/s / 22|Fri Aug  4 02:14:43 UTC 2023, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 90000, j: 11294(125488.9us)|11508(127866.7us), n:0|0|0|0, pli:1|Fri Aug  4 02:14:11 UTC 2023 / 45|Fri Aug  4 02:14:44 UTC 2023, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):12|18, drift(ms):35.30, sr(Hz):90017.44"}
2023-08-04T10:14:44.167+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "mime": "video/h264"}
2023-08-04T10:14:44.167+0800    INFO    livekit rtc/participant.go:1817 unpublished track       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "trackInfo": "sid:"TR_VSh7i3mYSRRKGi" type:VIDEO width:1920 height:1080 source:SCREEN_SHARE layers:{width:1280 height:720 bitrate:1700000} layers:{quality:MEDIUM width:1920 height:1080 bitrate:3000000} layers:{quality:HIGH width:1920 height:1080 bitrate:2100000} mime_type:"video/H264" codecs:{mime_type:"video/h264" cid:"cff8616c-890a-4fc4-9d88-d704867c7b92"}"}
2023-08-04T10:14:44.170+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "track_unpublished"}
2023-08-04T10:14:44.180+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:14:44.301+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.42s, sn: 7790|8667, ep: 878|4.81/s, p: 878|4.81/s, l: 0|0.0/s|0.00%, b: 26291|1153.0bps|10536, f: 11|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 345(7187.5us)|534(11125.0us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):12|35, drift(ms):20.75, sr(Hz):48005.46"}
2023-08-04T10:14:44.301+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:42 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.04s, sn: 7791|8667, ep: 877|4.82/s, p: 877|4.82/s, l: 0|0.0/s|0.00%, b: 26278|1154.9bps|10524, f: 11|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 353(7354.2us)|802(16708.3us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):14|28, drift(ms):20.75, sr(Hz):48005.47"}
2023-08-04T10:14:44.301+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:41 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.42s, sn: 7790|8667, ep: 878|4.81/s, p: 878|4.81/s, l: 5|0.0/s|0.57%, b: 26291|1153.0bps|10536, f: 11|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 540(11250.0us)|650(13541.7us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):11|18, drift(ms):20.77, sr(Hz):48005.46"}
2023-08-04T10:14:44.301+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc": 1043781, "stats": "t: Fri Aug  4 02:11:42 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.04s, sn: 7791|8667, ep: 877|4.82/s, p: 877|4.82/s, l: 0|0.0/s|0.00%, b: 26278|1154.9bps|10524, f: 11|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 639(13312.5us)|639(13312.5us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):6|54, drift(ms):20.75, sr(Hz):48005.47"}
2023-08-04T10:14:44.301+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:11:42 UTC 2023|Fri Aug  4 02:14:44 UTC 2023|182.04s, sn: 7791|8667, ep: 877|4.82/s, p: 877|4.82/s, l: 0|0.0/s|0.00%, b: 26278|1154.9bps|10524, f: 11|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 610(12708.3us)|610(12708.3us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):36|36, drift(ms):20.71, sr(Hz):48005.46"}
2023-08-04T10:14:44.301+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:14:44.301+0800    INFO    livekit rtc/participant.go:1817 unpublished track       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "trackInfo": "sid:"TR_AsYqSLYCkC9XYN" source:SCREEN_SHARE_AUDIO mime_type:"audio/opus""}
2023-08-04T10:14:44.303+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "track_unpublished"}
2023-08-04T10:14:45.192+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:14:47.206+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:14:49.167+0800    INFO    livekit rtc/dynacastmanager.go:227      committing quality change       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "relayed": false, "force": true, "committedMaxSubscribedQuality": {"video/H264":2}, "maxSubscribedQuality": {"video/H264":3}}
2023-08-04T10:14:51.216+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:14:59.223+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:14:59.223+0800    WARN    livekit webhook/url_notifier.go:71      failed to send webhook  {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "track_unpublished", "error": "POST http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook giving up after 5 attempt(s): Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused"}
2023-08-04T10:14:59.233+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:15:00.240+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:15:02.283+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:15:06.294+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:15:09.711+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "error": "track cannot be found"}
2023-08-04T10:15:09.712+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "error": "track cannot be found"}
2023-08-04T10:15:09.875+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "error": "track cannot be found"}
2023-08-04T10:15:09.875+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "error": "track cannot be found"}
2023-08-04T10:15:11.619+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "error": "track cannot be found"}
2023-08-04T10:15:11.620+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "error": "track cannot be found"}
2023-08-04T10:15:11.819+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "error": "track cannot be found"}
2023-08-04T10:15:11.820+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "error": "track cannot be found"}
2023-08-04T10:15:11.954+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_AsYqSLYCkC9XYN", "error": "track cannot be found"}
2023-08-04T10:15:11.954+0800    INFO    livekit rtc/subscriptionmanager.go:338  unsubscribing from track after notFoundTimeout  {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_VSh7i3mYSRRKGi", "error": "track cannot be found"}
2023-08-04T10:15:14.314+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:15:14.314+0800    WARN    livekit webhook/url_notifier.go:71      failed to send webhook  {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "track_unpublished", "error": "POST http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook giving up after 5 attempt(s): Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused"}
2023-08-04T10:16:00.253+0800    INFO    livekit service/twirp.go:128    API RoomService.ListRooms       {"service": "RoomService", "method": "ListRooms", "room": ["188281452"], "duration": "231.515µs", "status": "200"}
2023-08-04T10:16:00.254+0800    INFO    livekit service/twirp.go:128    API RoomService.SendData        {"service": "RoomService", "method": "SendData", "room": "188281452", "size": 170, "duration": "370.765µs", "status": "200"}
2023-08-04T10:16:00.262+0800    INFO    livekit service/roommanager.go:630      deleting room   {"room": "188281452", "roomID": "RM_chHWZNHgqusf"}
2023-08-04T10:16:00.262+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:00.262+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:00.463+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc": 291992987, "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:00 UTC 2023|345.55s, sn: 25911|27149, ep: 1239|3.59/s, p: 1239|3.59/s, l: 0|0.0/s|0.00%, b: 99018|2292.4bps|14868, f: 94|0.3/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 160(3333.3us)|863(17979.2us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):6|15, drift(ms):20.29, sr(Hz):48002.82"}
2023-08-04T10:16:00.665+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:00 UTC 2023|345.76s, sn: 25910|27149, ep: 1240|3.59/s, p: 1240|3.59/s, l: 0|0.0/s|0.00%, b: 99096|2292.8bps|14880, f: 94|0.3/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 167(3479.2us)|439(9145.8us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):3|12, drift(ms):27.67, sr(Hz):48003.84"}
2023-08-04T10:16:00.866+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:00 UTC 2023|345.95s, sn: 25911|27149, ep: 1239|3.58/s, p: 1239|3.58/s, l: 0|0.0/s|0.00%, b: 99018|2289.8bps|14868, f: 94|0.3/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 158(3291.7us)|681(14187.5us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):11|50, drift(ms):19.98, sr(Hz):48002.77"}
2023-08-04T10:16:01.066+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|346.16s, sn: 25910|27149, ep: 1240|3.58/s, p: 1240|3.58/s, l: 0|0.0/s|0.00%, b: 99096|2290.2bps|14880, f: 94|0.3/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 166(3458.3us)|710(14791.7us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):9|20, drift(ms):20.79, sr(Hz):48002.88"}
2023-08-04T10:16:01.267+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|346.36s, sn: 25910|27149, ep: 1240|3.58/s, p: 1240|3.58/s, l: 0|0.0/s|0.00%, b: 99096|2288.8bps|14880, f: 94|0.3/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 162(3375.0us)|414(8625.0us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):17|24, drift(ms):22.40, sr(Hz):48003.10"}
2023-08-04T10:16:01.267+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_btumcF9fY87Z"}
2023-08-04T10:16:01.267+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "oldState": "ACTIVE"}
2023-08-04T10:16:01.268+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:01.268+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "mime": "audio/opus", "layer": 0, "direction": "upstream", "stats": "t: Fri Aug  4 02:10:14 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|346.55s, sn: 25900|28540, ep: 2641|7.62/s, p: 2641|7.62/s, l: 0|0.0/s|0.00%, b: 158999|3670.4bps|52820, f: 34|0.1/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 81(1700.4us)|1052(21929.2us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):7|23, drift(ms):-5.00, sr(Hz):47999.31"}
2023-08-04T10:16:01.269+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_43F6SpBPykfq"}
2023-08-04T10:16:01.269+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "oldState": "ACTIVE"}
2023-08-04T10:16:01.270+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:01.270+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|311.63s, sn: 32038|32551, ep: 514|1.65/s, p: 514|1.65/s, l: 0|0.0/s|0.00%, b: 43082|1106.0bps|6168, f: 59|0.2/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 159(3312.5us)|367(7645.8us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):10|19, drift(ms):37.15, sr(Hz):48098.20"}
2023-08-04T10:16:01.270+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:01.274+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:16:01.277+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AMR3DkRvHKKGGi", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:01.469+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:09:07 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|413.56s, sn: 671|14414, ep: 13744|33.23/s, p: 13744|33.23/s, l: 1|0.0/s|0.01%, b: 1164449|22525.2bps|164928, f: 215|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 322(6708.3us)|663(13812.5us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):13|48, drift(ms):19.96, sr(Hz):48002.32"}
2023-08-04T10:16:01.469+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|311.83s, sn: 32038|32552, ep: 515|1.65/s, p: 515|1.65/s, l: 0|0.0/s|0.00%, b: 43174|1107.6bps|6180, f: 60|0.2/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 150(3125.0us)|283(5895.8us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):5|16, drift(ms):20.00, sr(Hz):48003.08"}
2023-08-04T10:16:01.471+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:09:10 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|411.32s, sn: 770|14413, ep: 13644|33.17/s, p: 13644|33.17/s, l: 1|0.0/s|0.01%, b: 1155170|22467.6bps|163728, f: 213|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 224(4666.7us)|788(16416.7us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):8|64, drift(ms):-2.12, sr(Hz):47999.75"}
2023-08-04T10:16:01.471+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:08:58 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|423.46s, sn: 183|14423, ep: 14241|33.63/s, p: 14241|33.63/s, l: 34|0.1/s|0.24%, b: 1207875|22818.9bps|170892, f: 225|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 34|0.08/s, bd: 3036|57.4bps|408, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 34, c: 48000, j: 327(6812.5us)|658(13708.3us), n:34|34|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):6|16, drift(ms):20.38, sr(Hz):48002.31"}
2023-08-04T10:16:01.622+0800    INFO    livekit rtc/transport.go:1637   skipping negotiation, trying again later        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "transport": "SUBSCRIBER"}
2023-08-04T10:16:01.671+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:08:58 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|423.17s, sn: 208|14433, ep: 14226|33.62/s, p: 14226|33.62/s, l: 0|0.0/s|0.00%, b: 1206891|22816.2bps|170712, f: 225|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 309(6437.5us)|759(15812.5us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):9|185, drift(ms):20.23, sr(Hz):48002.29"}
2023-08-04T10:16:01.822+0800    INFO    livekit rtc/transport.go:1637   skipping negotiation, trying again later        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "transport": "SUBSCRIBER"}
2023-08-04T10:16:01.872+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:08:58 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|423.84s, sn: 184|14443, ep: 14260|33.64/s, p: 14260|33.64/s, l: 0|0.0/s|0.00%, b: 1209689|22832.7bps|171120, f: 225|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 426(8875.0us)|733(15270.8us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):8|76, drift(ms):20.35, sr(Hz):48002.30"}
2023-08-04T10:16:01.872+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_jxW6uaDaQb86"}
2023-08-04T10:16:01.873+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "oldState": "ACTIVE"}
2023-08-04T10:16:01.873+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:01.873+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:01.873+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "mime": "audio/opus", "layer": 0, "direction": "upstream", "stats": "t: Fri Aug  4 02:08:57 UTC 2023|Fri Aug  4 02:16:01 UTC 2023|424.07s, sn: 173|14442, ep: 14270|33.65/s, p: 14270|33.65/s, l: 0|0.0/s|0.00%, b: 1324574|24988.0bps|285400, f: 215|0.5/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 132(2757.6us)|954(19889.2us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):13|50, drift(ms):-5.73, sr(Hz):47999.35"}
2023-08-04T10:16:01.880+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AM4TfM4HamkWbE", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:02.023+0800    INFO    livekit rtc/transport.go:1637   skipping negotiation, trying again later        {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "transport": "SUBSCRIBER"}
2023-08-04T10:16:02.074+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:02 UTC 2023|312.41s, sn: 32039|32552, ep: 514|1.65/s, p: 514|1.65/s, l: 0|0.0/s|0.00%, b: 43086|1103.3bps|6168, f: 60|0.2/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 193(4020.8us)|335(6979.2us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):13|18, drift(ms):19.98, sr(Hz):48003.07"}
2023-08-04T10:16:02.074+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:02 UTC 2023|312.43s, sn: 32038|32561, ep: 524|1.68/s, p: 524|1.68/s, l: 0|0.0/s|0.00%, b: 44002|1126.7bps|6288, f: 69|0.2/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 149(3104.2us)|335(6979.2us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):10|32, drift(ms):20.23, sr(Hz):48003.11"}
2023-08-04T10:16:02.275+0800    INFO    livekit sfu/downtrack.go:857    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "direction": "downstream", "mime": "audio/opus", "ssrc":<PHONE_NUMBER>, "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:02 UTC 2023|312.61s, sn: 32039|32561, ep: 523|1.67/s, p: 523|1.67/s, l: 0|0.0/s|0.00%, b: 43914|1123.8bps|6276, f: 69|0.2/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 161(3354.2us)|338(7041.7us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):16|42, drift(ms):20.77, sr(Hz):48003.19"}
2023-08-04T10:16:02.275+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_c3zbSBoHxdvx"}
2023-08-04T10:16:02.275+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "oldState": "ACTIVE"}
2023-08-04T10:16:02.276+0800    INFO    livekit service/twirp.go:128    API RoomService.DeleteRoom      {"service": "RoomService", "method": "DeleteRoom", "room": "188281452", "duration": "2.014258617s", "status": "500", "error": "operation cannot be completed", "code": "internal"}
2023-08-04T10:16:02.277+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:02.277+0800    INFO    livekit buffer/buffer.go:330    rtp stats       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "mime": "audio/opus", "layer": 0, "direction": "upstream", "stats": "t: Fri Aug  4 02:10:49 UTC 2023|Fri Aug  4 02:16:02 UTC 2023|312.81s, sn: 32029|33906, ep: 1878|6.00/s, p: 1878|6.00/s, l: 0|0.0/s|0.00%, b: 96344|2463.9bps|37560, f: 9|0.0/s / 0|Mon Jan  1 00:00:00 UTC 0001, d: 0|0.00/s, bd: 0|0.0bps|0, pp: 0|0.00/s, bp: 0|0.0bps|0, o: 0, c: 48000, j: 76(1586.7us)|358(7472.3us), n:0|0|0|0, pli:0|Mon Jan  1 00:00:00 UTC 0001 / 0|Mon Jan  1 00:00:00 UTC 0001, fir:0|Mon Jan  1 00:00:00 UTC 0001, rtt(ms):6|12, drift(ms):-9.31, sr(Hz):47998.57"}
2023-08-04T10:16:02.278+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_3Uf4S65qVsUb"}
2023-08-04T10:16:02.278+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "oldState": "ACTIVE"}
2023-08-04T10:16:02.278+0800    INFO    livekit rtc/participant.go:675  participant closing     {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "sendLeave": true, "reason": "SERVICE_REQUEST_DELETE_ROOM", "isExpectedToResume": false}
2023-08-04T10:16:02.279+0800    INFO    livekit rtc/participant_signal.go:291   closing signal connection       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "reason": "PARTICIPANT_CLOSE", "connID": "CO_dqpD33dLYufR"}
2023-08-04T10:16:02.279+0800    INFO    livekit rtc/room.go:265 participant state changed       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "state": "DISCONNECTED", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "oldState": "ACTIVE"}
2023-08-04T10:16:02.279+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.280+0800    INFO    livekit rtc/room.go:663 closing room    {"room": "188281452", "roomID": "RM_chHWZNHgqusf"}
2023-08-04T10:16:02.280+0800    INFO    livekit service/roommanager.go:114      deleting room state     {"room": "188281452"}
2023-08-04T10:16:02.281+0800    INFO    livekit rtc/mediatrackreceiver.go:502   removing all subscribers for mime       {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "trackID": "TR_AM4uvBaA4o6ezG", "relayed": false, "mime": "audio/opus"}
2023-08-04T10:16:02.281+0800    INFO    livekit service/roommanager.go:481      room closed     {"room": "188281452", "roomID": "RM_chHWZNHgqusf"}
2023-08-04T10:16:02.281+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "connID": "CO_43F6SpBPykfq"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "connID": "CO_43F6SpBPykfq", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:53104: use of closed network connection"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "b450a2d452ccf9e151fe8946a74dc27c", "pID": "PA_neQqU3FLpC27", "remote": false, "connID": "CO_43F6SpBPykfq"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "connID": "CO_btumcF9fY87Z"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "connID": "CO_btumcF9fY87Z", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:53080: use of closed network connection"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "82556d50f4bcab73faaa71a5b321867c", "pID": "PA_nvX9ja9s7LxN", "remote": false, "connID": "CO_btumcF9fY87Z"}
2023-08-04T10:16:02.282+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}
github.com/hashicorp/go-retryablehttp.(*Client).Do
/home/runner/go/pkg/mod/github.com/hashicorp/go-retryablehttp@v0.7.4/client.go:654
github.com/livekit/protocol/webhook.(*URLNotifier).send
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:119
github.com/livekit/protocol/webhook.(*URLNotifier).QueueNotify.func1
/home/runner/go/pkg/mod/github.com/livekit/protocol@v1.5.9/webhook/url_notifier.go:70
github.com/frostbyte73/core.(*worker).run
/home/runner/go/pkg/mod/github.com/frostbyte73/core@v0.0.9/pool.go:138
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "connID": "CO_dqpD33dLYufR"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "connID": "CO_dqpD33dLYufR", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:52672: use of closed network connection"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "f9e4255a945e3caa416afd6abbdde788", "pID": "PA_HcaoMDJaPti4", "remote": false, "connID": "CO_dqpD33dLYufR"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "connID": "CO_c3zbSBoHxdvx"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "connID": "CO_c3zbSBoHxdvx", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:52474: use of closed network connection"}
2023-08-04T10:16:02.282+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "5da0a1c520e314bc1733e8f4ad66d23a", "pID": "PA_Rzvcw5pq4Qtj", "remote": false, "connID": "CO_c3zbSBoHxdvx"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "connID": "CO_3Uf4S65qVsUb"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "connID": "CO_3Uf4S65qVsUb", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:52490: use of closed network connection"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "a27eb2d1f56c04132bee93e2a9273b02", "pID": "PA_ZHZCHVqmpmKU", "remote": false, "connID": "CO_3Uf4S65qVsUb"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:309       nothing to read from response source    {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "connID": "CO_jxW6uaDaQb86"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:352       exit ws read loop for closed connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "connID": "CO_jxW6uaDaQb86", "wsError": "read tcp <IP_ADDRESS>:7880-><IP_ADDRESS>:50986: use of closed network connection"}
2023-08-04T10:16:02.283+0800    INFO    livekit service/rtcservice.go:247       finishing WS connection {"room": "188281452", "roomID": "RM_chHWZNHgqusf", "participant": "9afd8fa9736ed8a0a876744ea2af8847", "pID": "PA_UsusSAXGdz8n", "remote": false, "connID": "CO_jxW6uaDaQb86"}
2023-08-04T10:16:02.284+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.287+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.290+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.295+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.298+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "participant_left"}
2023-08-04T10:16:02.302+0800    INFO    livekit webhook/url_notifier.go:74      sent webhook    {"url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook", "event": "room_finished"}
2023-08-04T10:16:04.290+0800    ERROR   livekit go-retryablehttp@v0.7.4/client.go:654   request failed  {"error": "Post "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook\": dial tcp <IP_ADDRESS>:6015: connect: connection refused", "method": "POST", "url": "http://<IP_ADDRESS>:6015/vm/v1/adapter/webhook"}

Thank you for the logs. I see five subscribers. Can you provide some more detail of which subscriber has the issue?
I am a bit confused, between

losing video only.
which seems to indicate only screen share video is lost, but audio continues to work and the receiver remains connected to the room.

The receiver disconnects, but the screen sharing sender continues to send
This indicates that receiver is completely disconnecting, i. e. it is gone from the room.

Can you try the latest master code? It is fine if you attach the full logs, but will appreciate some details like

Publisher () started publishing screen share at approx time .
Receiver () joined at approx time  and started subscribing to screen share track.
Problem for receiver in Step 2 happened at approx. time
Don't need exact details, approximate times. More importantly need the identity of the receiver to debug better. Please feel free to attach full server logs. If you provide time stamps, I can narrow it down from full logs.

I will do the test again and record all the logs. I will provide these logs and some details later

Hey, I got full log.
debug.log

Thank you. Can you also provide the following information?
Can you try the latest master code? It is fine if you attach the full logs, but will appreciate some details like

Publisher (<identity>) started publishing screen share at approx time .
Receiver (<identity>) joined at approx time and started subscribing to screen share track.
Problem for receiver in Step 2 happened at approx. time
Don't need exact details, approximate times. More importantly need the identity of the receiver to debug better. Please feel free to attach full server logs. If you provide time stamps, I can narrow it down from full logs.

It is hard to pin point the problem without these details.

Publisher<Identity: 5da0a1c520e314bc1733e8f4ad66d23a> started publishing screen share around  8:56.
Receiver<Identity: others> joined around 8:58 ~ 9:00.
There is more than one receiver. It can be understood that all are receivers except the publisher.

Did all receivers face the problem? Did all of them disconnect?

All receivers are not disconnected, just unable to see the screen share.
client sdk receive TrackUnmuted event.

From the logs, it looks like all your subscribers are congested. I am guessing you are not seeing screen share update. When congestion happens, packet losses will happen and screen share decoding on subscriber will lose sync and cannot render. That is expected behaviour.
If screen share is not using simulcast like in your logs, we do not congestion control.
If you want congestion control, you can enable simulcast for screen share tracks (just like you would do for camera track) and congestion control will try to use lower resolution layer to fit within available bandwidth. But, your subscribers are very congested (maybe you are running multiple subscribers on the same machine/network?). Even that may not help.
But, this is working as expected.