srs WebRTC: 开机后第一次向 srs 推流失败

WebRTC: 开机后第一次向 srs 推流失败

Open YonLJ opened this issue 3 years ago • 1 comments
Description(描述)
某个Windows11用户 user-4 在开机后第一次进行会议向 srs 推流失败，客户端向 srs 发送 offer 后srs 返回的 answer 为 {code: 400}， webrtc 连接状态为 disconnected，第一次之后重新进行会议则能正常推流，当前只发现用户user-4在开机后首次发起会议必现此问题
SRS Version(版本): docker 部署的 4.0 版本
SRS 日志
2022-05-19T03:29:31.936454777Z [2022-05-19 03:29:31.935][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(54,rtp:50,stun:1,rtcp:2), spkts=(69,rtp:50,stun:1,rtcp:27), rtcp=(pli:0,twcc:19,rr:2), snk=(194,a:97,v:97,h:0), fid=(id:0,fid:54,ffid:0,addr:1,faddr:54)
2022-05-19T03:29:31.936465902Z [2022-05-19 03:29:31.935][Trace][1][izz3d6tt] RTC: clear zombies=1 resources, conns=4, removing=0, unsubs=0
2022-05-19T03:29:31.936476025Z [2022-05-19 03:29:31.935][Trace][1][ci9e59z7] RTC: disposing #0 resource(RtcConn)(0x160d910), conns=4, disposing=1, zombies=0
2022-05-19T03:29:31.936486483Z [2022-05-19 03:29:31.936][Trace][1][ci9e59z7] cleanup when unpublish, created=1, deliver=1
2022-05-19T03:29:34.515095128Z [2022-05-19 03:29:34.514][Trace][1][92m98j1y] HTTP #6 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._7, content-length=-1
2022-05-19T03:29:35.140521540Z [2022-05-19 03:29:35.140][Trace][1][53cu8107] HTTP #1344 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._251, content-length=-1
2022-05-19T03:29:36.717686863Z [2022-05-19 03:29:36.717][Trace][1][07v7yjfo] TCP: before dispose resource(HttpConn)(0x17e5e80), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:36.717742799Z [2022-05-19 03:29:36.717][Trace][1][07v7yjfo] client finished.
2022-05-19T03:29:36.717756417Z [2022-05-19 03:29:36.717][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:29:36.717767315Z [2022-05-19 03:29:36.717][Trace][1][07v7yjfo] TCP: disposing #0 resource(HttpConn)(0x17e5e80), conns=3, disposing=1, zombies=0
2022-05-19T03:29:36.937110524Z [2022-05-19 03:29:36.936][Trace][1][10ju9479] Hybrid cpu=1.00%,17MB, cid=5,4, timer=62,16,170, clock=0,42,5,0,0,0,0,0,0, free=1, objs=(pkt:87,raw:87,fua:0,msg:87,oth:0,buf:43)
2022-05-19T03:29:36.937167500Z [2022-05-19 03:29:36.936][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(47,rtp:43,stun:1,rtcp:2), spkts=(59,rtp:43,stun:1,rtcp:23), rtcp=(pli:0,twcc:14,rr:1), snk=(145,a:72,v:72,h:0), fid=(id:0,fid:47,ffid:0,addr:1,faddr:47)
2022-05-19T03:29:37.542046146Z [2022-05-19 03:29:37.541][Trace][1][92m98j1y] HTTP #7 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._8, content-length=-1
2022-05-19T03:29:37.596348735Z [2022-05-19 03:29:37.596][Trace][1][i0z03797] <- RTC RECV #10, udp 447, pps 7/44, schedule 447
2022-05-19T03:29:39.143046520Z [2022-05-19 03:29:39.142][Trace][1][53cu8107] HTTP #1345 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._252, content-length=-1
2022-05-19T03:29:40.569520386Z [2022-05-19 03:29:40.569][Trace][1][92m98j1y] HTTP #8 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._9, content-length=-1
2022-05-19T03:29:41.937606543Z [2022-05-19 03:29:41.937][Trace][1][10ju9479] Hybrid cpu=0.00%,17MB, cid=5,4, timer=62,16,170, clock=0,42,5,0,0,0,0,0,0, free=1, objs=(pkt:87,raw:87,fua:0,msg:87,oth:0,buf:43)
2022-05-19T03:29:41.937663865Z [2022-05-19 03:29:41.937][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(47,rtp:43,stun:1,rtcp:2), spkts=(59,rtp:43,stun:1,rtcp:23), rtcp=(pli:0,twcc:14,rr:1), snk=(145,a:72,v:72,h:0), fid=(id:0,fid:47,ffid:0,addr:1,faddr:47)
2022-05-19T03:29:43.128474007Z [2022-05-19 03:29:43.128][Trace][1][53cu8107] HTTP #1346 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._253, content-length=-1
2022-05-19T03:29:43.592346038Z [2022-05-19 03:29:43.592][Trace][1][92m98j1y] HTTP #9 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._a, content-length=-1
2022-05-19T03:29:46.617273493Z [2022-05-19 03:29:46.616][Trace][1][92m98j1y] HTTP #10 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._b, content-length=-1
2022-05-19T03:29:46.938517967Z [2022-05-19 03:29:46.938][Trace][1][10ju9479] Hybrid cpu=1.00%,17MB, cid=5,4, timer=62,16,170, clock=0,42,5,0,0,0,0,0,0, free=1, objs=(pkt:87,raw:87,fua:0,msg:87,oth:0,buf:43)
2022-05-19T03:29:46.938573631Z [2022-05-19 03:29:46.938][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(47,rtp:43,stun:1,rtcp:2), spkts=(59,rtp:43,stun:1,rtcp:23), rtcp=(pli:0,twcc:14,rr:1), snk=(145,a:72,v:72,h:0), fid=(id:0,fid:47,ffid:0,addr:1,faddr:47)
2022-05-19T03:29:47.136521880Z [2022-05-19 03:29:47.136][Trace][1][53cu8107] HTTP #1347 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._254, content-length=-1
2022-05-19T03:29:47.623943505Z [2022-05-19 03:29:47.623][Trace][1][i0z03797] <- RTC RECV #10, udp 38, pps 7/3, schedule 38
2022-05-19T03:29:49.641325371Z [2022-05-19 03:29:49.640][Trace][1][92m98j1y] HTTP #11 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._c, content-length=-1
2022-05-19T03:29:50.383370207Z [2022-05-19 03:29:50.382][Trace][1][0wg0w5a3] HTTP #0 10.0.0.86:50432 GET http://10.8.1.25:8080/console/ng_index.html, content-length=-1
2022-05-19T03:29:50.383474189Z [2022-05-19 03:29:50.382][Trace][1][0wg0w5a3] http match file=./objs/nginx/html/console/ng_index.html, pattern=/, upath=/console/ng_index.html
2022-05-19T03:29:50.389040753Z [2022-05-19 03:29:50.388][Trace][1][0wg0w5a3] TCP: before dispose resource(HttpStream)(0x16d34c0), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.389106162Z [33m[2022-05-19 03:29:50.388][Warn][1][0wg0w5a3][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.389120286Z [0m[2022-05-19 03:29:50.388][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:29:50.389131458Z [2022-05-19 03:29:50.388][Trace][1][0wg0w5a3] TCP: disposing #0 resource(HttpStream)(0x16d34c0), conns=3, disposing=1, zombies=0
2022-05-19T03:29:50.447329464Z [2022-05-19 03:29:50.446][Trace][1][cm6al590] HTTP #0 10.0.0.86:50433 GET http://10.8.1.25:8080/console/js/3rdparty/bootstrap.min.css, content-length=-1
2022-05-19T03:29:50.447427245Z [2022-05-19 03:29:50.446][Trace][1][cm6al590] http match file=./objs/nginx/html/console/js/3rdparty/bootstrap.min.css, pattern=/, upath=/console/js/3rdparty/bootstrap.min.css
2022-05-19T03:29:50.448399783Z [2022-05-19 03:29:50.447][Trace][1][y1z600l1] HTTP #0 10.0.0.86:50434 GET http://10.8.1.25:8080/console/js/srs.console.css, content-length=-1
2022-05-19T03:29:50.448439882Z [2022-05-19 03:29:50.448][Trace][1][y1z600l1] http match file=./objs/nginx/html/console/js/srs.console.css, pattern=/, upath=/console/js/srs.console.css
2022-05-19T03:29:50.448862791Z [2022-05-19 03:29:50.448][Trace][1][1216108l] HTTP #0 10.0.0.86:50435 GET http://10.8.1.25:8080/console/js/3rdparty/angular.min.js, content-length=-1
2022-05-19T03:29:50.448902877Z [2022-05-19 03:29:50.448][Trace][1][1216108l] http match file=./objs/nginx/html/console/js/3rdparty/angular.min.js, pattern=/, upath=/console/js/3rdparty/angular.min.js
2022-05-19T03:29:50.449754524Z [2022-05-19 03:29:50.449][Trace][1][64299225] HTTP #0 10.0.0.86:50437 GET http://10.8.1.25:8080/console/js/3rdparty/angular-resource.min.js, content-length=-1
2022-05-19T03:29:50.449795612Z [2022-05-19 03:29:50.449][Trace][1][64299225] http match file=./objs/nginx/html/console/js/3rdparty/angular-resource.min.js, pattern=/, upath=/console/js/3rdparty/angular-resource.min.js
2022-05-19T03:29:50.450164400Z [2022-05-19 03:29:50.449][Trace][1][88094f98] HTTP #0 10.0.0.86:50436 GET http://10.8.1.25:8080/console/js/3rdparty/angular-route.min.js, content-length=-1
2022-05-19T03:29:50.450204949Z [2022-05-19 03:29:50.449][Trace][1][88094f98] http match file=./objs/nginx/html/console/js/3rdparty/angular-route.min.js, pattern=/, upath=/console/js/3rdparty/angular-route.min.js
2022-05-19T03:29:50.450858555Z [2022-05-19 03:29:50.450][Trace][1][08yktj10] HTTP #0 10.0.0.86:50438 GET http://10.8.1.25:8080/console/js/winlin.utility.js, content-length=-1
2022-05-19T03:29:50.450899962Z [2022-05-19 03:29:50.450][Trace][1][08yktj10] http match file=./objs/nginx/html/console/js/winlin.utility.js, pattern=/, upath=/console/js/winlin.utility.js
2022-05-19T03:29:50.459150240Z [2022-05-19 03:29:50.458][Trace][1][y1z600l1] TCP: before dispose resource(HttpStream)(0x16af950), conns=8, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.459193490Z [33m[2022-05-19 03:29:50.458][Warn][1][y1z600l1][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.459207290Z [0m[2022-05-19 03:29:50.458][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=8, removing=0, unsubs=0
2022-05-19T03:29:50.459218232Z [2022-05-19 03:29:50.458][Trace][1][y1z600l1] TCP: disposing #0 resource(HttpStream)(0x16af950), conns=8, disposing=1, zombies=0
2022-05-19T03:29:50.467844705Z [2022-05-19 03:29:50.467][Trace][1][64299225] TCP: before dispose resource(HttpStream)(0x1671d50), conns=7, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.467888370Z [33m[2022-05-19 03:29:50.467][Warn][1][64299225][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.467902535Z [0m[2022-05-19 03:29:50.467][Trace][1][88094f98] TCP: before dispose resource(HttpStream)(0x1756270), conns=7, zombies=1, ign=0, inz=0, ind=0
2022-05-19T03:29:50.467937493Z [33m[2022-05-19 03:29:50.467][Warn][1][88094f98][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.467948944Z [0m[2022-05-19 03:29:50.467][Trace][1][08yktj10] TCP: before dispose resource(HttpStream)(0x174faa0), conns=7, zombies=2, ign=0, inz=0, ind=0
2022-05-19T03:29:50.467959696Z [33m[2022-05-19 03:29:50.467][Warn][1][08yktj10][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.467969819Z [0m[2022-05-19 03:29:50.467][Trace][1][m0b37799] TCP: clear zombies=3 resources, conns=7, removing=0, unsubs=0
2022-05-19T03:29:50.467982713Z [2022-05-19 03:29:50.467][Trace][1][64299225] TCP: disposing #0 resource(HttpStream)(0x1671d50), conns=7, disposing=3, zombies=0
2022-05-19T03:29:50.467993126Z [2022-05-19 03:29:50.467][Trace][1][88094f98] TCP: disposing #1 resource(HttpStream)(0x1756270), conns=6, disposing=3, zombies=0
2022-05-19T03:29:50.468046947Z [2022-05-19 03:29:50.467][Trace][1][08yktj10] TCP: disposing #2 resource(HttpStream)(0x174faa0), conns=5, disposing=3, zombies=0
2022-05-19T03:29:50.469073545Z [2022-05-19 03:29:50.468][Trace][1][236x34zj] HTTP #0 10.0.0.86:50439 GET http://10.8.1.25:8080/console/js/bravo_alert/alert.js, content-length=-1
2022-05-19T03:29:50.469117199Z [2022-05-19 03:29:50.468][Trace][1][236x34zj] http match file=./objs/nginx/html/console/js/bravo_alert/alert.js, pattern=/, upath=/console/js/bravo_alert/alert.js
2022-05-19T03:29:50.473184558Z [2022-05-19 03:29:50.472][Trace][1][cm6al590] TCP: before dispose resource(HttpStream)(0x16d34c0), conns=5, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.473227356Z [33m[2022-05-19 03:29:50.472][Warn][1][cm6al590][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.473241322Z [0m[2022-05-19 03:29:50.472][Trace][1][1216108l] TCP: before dispose resource(HttpStream)(0x1744470), conns=5, zombies=1, ign=0, inz=0, ind=0
2022-05-19T03:29:50.473252391Z [33m[2022-05-19 03:29:50.472][Warn][1][1216108l][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.473831631Z [0m[2022-05-19 03:29:50.473][Trace][1][m0b37799] TCP: clear zombies=2 resources, conns=8, removing=0, unsubs=0
2022-05-19T03:29:50.473872083Z [2022-05-19 03:29:50.473][Trace][1][cm6al590] TCP: disposing #0 resource(HttpStream)(0x16d34c0), conns=8, disposing=2, zombies=0
2022-05-19T03:29:50.473885535Z [2022-05-19 03:29:50.473][Trace][1][1216108l] TCP: disposing #1 resource(HttpStream)(0x1744470), conns=7, disposing=2, zombies=0
2022-05-19T03:29:50.474532635Z [2022-05-19 03:29:50.474][Trace][1][8181x0n2] HTTP #0 10.0.0.86:50440 GET http://10.8.1.25:8080/console/js/bravo_popover/popover.js, content-length=-1
2022-05-19T03:29:50.474573091Z [2022-05-19 03:29:50.474][Trace][1][8181x0n2] http match file=./objs/nginx/html/console/js/bravo_popover/popover.js, pattern=/, upath=/console/js/bravo_popover/popover.js
2022-05-19T03:29:50.475547070Z [2022-05-19 03:29:50.475][Trace][1][93b3i5v8] HTTP #0 10.0.0.86:50441 GET http://10.8.1.25:8080/console/js/srs.cn.js, content-length=-1
2022-05-19T03:29:50.475590509Z [2022-05-19 03:29:50.475][Trace][1][93b3i5v8] http match file=./objs/nginx/html/console/js/srs.cn.js, pattern=/, upath=/console/js/srs.cn.js
2022-05-19T03:29:50.476366856Z [2022-05-19 03:29:50.475][Trace][1][t982t021] HTTP #0 10.0.0.86:50442 GET http://10.8.1.25:8080/console/js/srs.console.js, content-length=-1
2022-05-19T03:29:50.476427922Z [2022-05-19 03:29:50.476][Trace][1][t982t021] http match file=./objs/nginx/html/console/js/srs.console.js, pattern=/, upath=/console/js/srs.console.js
2022-05-19T03:29:50.477215037Z [2022-05-19 03:29:50.476][Trace][1][236x34zj] TCP: before dispose resource(HttpStream)(0x173faa0), conns=6, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.477256540Z [33m[2022-05-19 03:29:50.476][Warn][1][236x34zj][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.477271255Z [0m[2022-05-19 03:29:50.476][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=6, removing=0, unsubs=0
2022-05-19T03:29:50.477282533Z [2022-05-19 03:29:50.476][Trace][1][236x34zj] TCP: disposing #0 resource(HttpStream)(0x173faa0), conns=6, disposing=1, zombies=0
2022-05-19T03:29:50.482177832Z [2022-05-19 03:29:50.481][Trace][1][8181x0n2] TCP: before dispose resource(HttpStream)(0x163b2e0), conns=5, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.482221796Z [33m[2022-05-19 03:29:50.481][Warn][1][8181x0n2][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.482235695Z [0m[2022-05-19 03:29:50.481][Trace][1][93b3i5v8] TCP: before dispose resource(HttpStream)(0x16af950), conns=5, zombies=1, ign=0, inz=0, ind=0
2022-05-19T03:29:50.482247123Z [33m[2022-05-19 03:29:50.481][Warn][1][93b3i5v8][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.482277896Z [0m[2022-05-19 03:29:50.481][Trace][1][m0b37799] TCP: clear zombies=2 resources, conns=5, removing=0, unsubs=0
2022-05-19T03:29:50.482289357Z [2022-05-19 03:29:50.481][Trace][1][8181x0n2] TCP: disposing #0 resource(HttpStream)(0x163b2e0), conns=5, disposing=2, zombies=0
2022-05-19T03:29:50.482299911Z [2022-05-19 03:29:50.481][Trace][1][93b3i5v8] TCP: disposing #1 resource(HttpStream)(0x16af950), conns=4, disposing=2, zombies=0
2022-05-19T03:29:50.484939335Z [2022-05-19 03:29:50.484][Trace][1][t982t021] TCP: before dispose resource(HttpStream)(0x17427f0), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.484983588Z [33m[2022-05-19 03:29:50.484][Warn][1][t982t021][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.484997303Z [0m[2022-05-19 03:29:50.484][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:29:50.485009515Z [2022-05-19 03:29:50.484][Trace][1][t982t021] TCP: disposing #0 resource(HttpStream)(0x17427f0), conns=3, disposing=1, zombies=0
2022-05-19T03:29:50.538096365Z [2022-05-19 03:29:50.537][Trace][1][3z86375c] HTTP #0 10.0.0.86:50444 GET http://10.8.1.25:8080/console/views/clients.html, content-length=-1
2022-05-19T03:29:50.538139885Z [2022-05-19 03:29:50.537][Trace][1][3z86375c] http match file=./objs/nginx/html/console/views/clients.html, pattern=/, upath=/console/views/clients.html
2022-05-19T03:29:50.542728133Z [2022-05-19 03:29:50.542][Trace][1][3z86375c] TCP: before dispose resource(HttpStream)(0x17427f0), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:50.542772078Z [33m[2022-05-19 03:29:50.542][Warn][1][3z86375c][104] client disconnect peer. ret=1007
2022-05-19T03:29:50.542786400Z [0m[2022-05-19 03:29:50.542][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:29:50.542818225Z [2022-05-19 03:29:50.542][Trace][1][3z86375c] TCP: disposing #0 resource(HttpStream)(0x17427f0), conns=3, disposing=1, zombies=0
2022-05-19T03:29:50.597188443Z [2022-05-19 03:29:50.596][Trace][1][92m98j1y] HTTP #12 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._0, content-length=-1
2022-05-19T03:29:51.159284287Z [2022-05-19 03:29:51.158][Trace][1][53cu8107] HTTP #1348 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._255, content-length=-1
2022-05-19T03:29:51.209588964Z [2022-05-19 03:29:51.209][Trace][1][11468n9z] RTC: session address change 10.0.0.84:56626 -> 10.0.0.82:62661, cached=1, nn_change=5/3, nn_address=2
2022-05-19T03:29:51.259593103Z [2022-05-19 03:29:51.259][Trace][1][2k9029y6] RTC: session address change 10.0.0.84:53026 -> 10.0.0.82:52502, cached=1, nn_change=5/3, nn_address=2
2022-05-19T03:29:51.938487508Z [2022-05-19 03:29:51.938][Trace][1][10ju9479] Hybrid cpu=2.00%,17MB, cid=14,9, timer=62,10,147, clock=0,48,1,0,0,0,0,0,0, free=1
2022-05-19T03:29:51.938504993Z [2022-05-19 03:29:51.938][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(3,rtp:0,stun:1,rtcp:2), spkts=(5,rtp:0,stun:1,rtcp:4), rtcp=(pli:0,twcc:9,rr:1), snk=(98,a:49,v:49,h:0), fid=(id:0,fid:3,ffid:0,addr:1,faddr:3)
2022-05-19T03:29:53.267340639Z [2022-05-19 03:29:53.266][Trace][1][2k9029y6] RTC: session address change 10.0.0.82:52502 -> 10.0.0.84:53026, cached=1, nn_change=6/3, nn_address=2
2022-05-19T03:29:53.511145203Z [2022-05-19 03:29:53.510][Trace][1][11468n9z] RTC: session address change 10.0.0.82:62661 -> 10.0.0.84:56626, cached=1, nn_change=6/3, nn_address=2
2022-05-19T03:29:53.628298864Z [2022-05-19 03:29:53.628][Trace][1][92m98j1y] HTTP #13 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._1, content-length=-1
2022-05-19T03:29:55.129146241Z [2022-05-19 03:29:55.128][Trace][1][53cu8107] HTTP #1349 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._256, content-length=-1
2022-05-19T03:29:56.687796394Z [2022-05-19 03:29:56.687][Trace][1][92m98j1y] HTTP #14 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._2, content-length=-1
2022-05-19T03:29:56.939483468Z [2022-05-19 03:29:56.939][Trace][1][10ju9479] Hybrid cpu=2.00%,17MB, cid=14,9, timer=62,10,147, clock=0,48,1,0,0,0,0,0,0, free=1
2022-05-19T03:29:56.939502528Z [2022-05-19 03:29:56.939][Trace][1][10ju9479] RTC: Server conns=3, rpkts=(3,rtp:0,stun:1,rtcp:2), spkts=(5,rtp:0,stun:1,rtcp:4), rtcp=(pli:0,twcc:9,rr:1), snk=(98,a:49,v:49,h:0), fid=(id:0,fid:3,ffid:0,addr:1,faddr:3)
2022-05-19T03:29:57.721026146Z [2022-05-19 03:29:57.720][Trace][1][i0z03797] <- RTC RECV #10, udp 42, pps 7/4, schedule 42
2022-05-19T03:29:59.133401210Z [2022-05-19 03:29:59.133][Trace][1][53cu8107] HTTP #1350 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._257, content-length=-1
2022-05-19T03:29:59.731686426Z [2022-05-19 03:29:59.731][Trace][1][92m98j1y] HTTP #15 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._3, content-length=-1
2022-05-19T03:29:59.868856633Z [2022-05-19 03:29:59.868][Trace][1][369thl79] DTLS: State Passive RECV, done=1, arq=0/0, r0=1, r1=0, len=39, cnt=21, size=26, hs=0
2022-05-19T03:29:59.868947302Z [33m[2022-05-19 03:29:59.868][Warn][1][369thl79][0] DTLS: SSL3 alert method=read type=warning, desc=CN(close notify), where=16388, ret=256, r1=0
2022-05-19T03:29:59.868963508Z [0m[2022-05-19 03:29:59.868][Trace][1][369thl79] RTC: session destroy by DTLS alert, username=3k519n81:TO8X
2022-05-19T03:29:59.868974404Z [2022-05-19 03:29:59.868][Trace][1][369thl79] RTC: before dispose resource(RtcConn)(0x16e97d0), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:59.868985187Z [2022-05-19 03:29:59.868][Trace][1][369thl79] RTC: session detach from [369thl79](RtcConn), disposing=1
2022-05-19T03:29:59.868995571Z [2022-05-19 03:29:59.868][Trace][1][izz3d6tt] RTC: clear zombies=1 resources, conns=3, removing=0, unsubs=1
2022-05-19T03:29:59.869005953Z [2022-05-19 03:29:59.868][Trace][1][369thl79] RTC: disposing #0 resource(RtcConn)(0x16e97d0), conns=3, disposing=1, zombies=0
2022-05-19T03:29:59.886718937Z [2022-05-19 03:29:59.886][Trace][1][2k9029y6] DTLS: State Passive RECV, done=1, arq=0/0, r0=1, r1=0, len=39, cnt=21, size=26, hs=0
2022-05-19T03:29:59.886762289Z [33m[2022-05-19 03:29:59.886][Warn][1][2k9029y6][0] DTLS: SSL3 alert method=read type=warning, desc=CN(close notify), where=16388, ret=256, r1=0
2022-05-19T03:29:59.886776525Z [0m[2022-05-19 03:29:59.886][Trace][1][2k9029y6] RTC: session destroy by DTLS alert, username=93g37cp6:kSay
2022-05-19T03:29:59.886787753Z [2022-05-19 03:29:59.886][Trace][1][2k9029y6] RTC: before dispose resource(RtcConn)(0x16c2cc0), conns=2, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:59.886798550Z [2022-05-19 03:29:59.886][Trace][1][2k9029y6] RTC: session detach from [2k9029y6](RtcConn), disposing=1
2022-05-19T03:29:59.886809310Z [2022-05-19 03:29:59.886][Trace][1][izz3d6tt] RTC: clear zombies=1 resources, conns=2, removing=0, unsubs=1
2022-05-19T03:29:59.886819613Z [2022-05-19 03:29:59.886][Trace][1][2k9029y6] RTC: disposing #0 resource(RtcConn)(0x16c2cc0), conns=2, disposing=1, zombies=0
2022-05-19T03:29:59.955943071Z [2022-05-19 03:29:59.955][Trace][1][2e308687] HTTP #0 10.0.0.8:47934 DELETE http://10.8.1.25:1985/v1/rooms/261-4, content-length=0
2022-05-19T03:29:59.996494069Z [2022-05-19 03:29:59.996][Trace][1][2e308687] TCP: before dispose resource(HttpConn)(0x1639b50), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:29:59.996546537Z [33m[2022-05-19 03:29:59.996][Warn][1][2e308687][104] client disconnect peer. ret=1007
2022-05-19T03:29:59.996560395Z [0m[2022-05-19 03:29:59.996][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:29:59.996571661Z [2022-05-19 03:29:59.996][Trace][1][2e308687] TCP: disposing #0 resource(HttpConn)(0x1639b50), conns=3, disposing=1, zombies=0
2022-05-19T03:30:00.022140730Z [2022-05-19 03:30:00.021][Trace][1][11468n9z] DTLS: State Passive RECV, done=1, arq=0/0, r0=1, r1=0, len=39, cnt=21, size=26, hs=0
2022-05-19T03:30:00.022196816Z [33m[2022-05-19 03:30:00.021][Warn][1][11468n9z][0] DTLS: SSL3 alert method=read type=warning, desc=CN(close notify), where=16388, ret=256, r1=0
2022-05-19T03:30:00.022212161Z [0m[2022-05-19 03:30:00.021][Trace][1][11468n9z] RTC: session destroy by DTLS alert, username=0407g764:qMkN
2022-05-19T03:30:00.022253031Z [2022-05-19 03:30:00.021][Trace][1][11468n9z] RTC: before dispose resource(RtcConn)(0x17430f0), conns=1, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:30:00.022265117Z [2022-05-19 03:30:00.021][Trace][1][11468n9z] RTC: session detach from [11468n9z](RtcConn), disposing=1
2022-05-19T03:30:00.022275461Z [2022-05-19 03:30:00.021][Trace][1][izz3d6tt] RTC: clear zombies=1 resources, conns=1, removing=0, unsubs=1
2022-05-19T03:30:00.022285781Z [2022-05-19 03:30:00.021][Trace][1][11468n9z] RTC: disposing #0 resource(RtcConn)(0x17430f0), conns=1, disposing=1, zombies=0
2022-05-19T03:30:00.022648411Z [2022-05-19 03:30:00.022][Trace][1][11468n9z] cleanup when unpublish, created=1, deliver=1
2022-05-19T03:30:01.940648945Z [2022-05-19 03:30:01.940][Trace][1][10ju9479] Hybrid cpu=1.00%,17MB, cid=8,6, timer=62,8,117, clock=0,47,1,0,0,0,0,0,0, free=1
2022-05-19T03:30:02.765013003Z [2022-05-19 03:30:02.764][Trace][1][92m98j1y] HTTP #16 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._4, content-length=-1
2022-05-19T03:30:03.125385017Z [2022-05-19 03:30:03.125][Trace][1][53cu8107] HTTP #1351 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._258, content-length=-1
2022-05-19T03:30:05.792556086Z [2022-05-19 03:30:05.792][Trace][1][92m98j1y] HTTP #17 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._5, content-length=-1
2022-05-19T03:30:06.016877382Z [2022-05-19 03:30:06.016][Trace][1][9307e558] HTTP #0 10.0.0.8:47948 GET http://10.8.1.25:1985/v1/rooms/261-4, content-length=0
2022-05-19T03:30:06.056746200Z [2022-05-19 03:30:06.056][Trace][1][9307e558] TCP: before dispose resource(HttpConn)(0x1640390), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:30:06.056768247Z [33m[2022-05-19 03:30:06.056][Warn][1][9307e558][104] client disconnect peer. ret=1007
2022-05-19T03:30:06.056774294Z [0m[2022-05-19 03:30:06.056][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:30:06.056778979Z [2022-05-19 03:30:06.056][Trace][1][9307e558] TCP: disposing #0 resource(HttpConn)(0x1640390), conns=3, disposing=1, zombies=0
2022-05-19T03:30:06.941533451Z [2022-05-19 03:30:06.941][Trace][1][10ju9479] Hybrid cpu=1.00%,17MB, cid=8,6, timer=62,8,117, clock=0,47,1,0,0,0,0,0,0, free=1
2022-05-19T03:30:07.063607494Z [2022-05-19 03:30:07.063][Trace][1][5uq4a393] HTTP #0 10.0.0.86:62023 POST http://10.8.1.25:1985/rtc/v1/publish/, content-length=6110
2022-05-19T03:30:07.064096739Z [2022-05-19 03:30:07.063][Trace][1][5uq4a393] RTC publish webrtc://10.8.1.25/261-4/user-4/, api=http://10.8.1.25:1985/rtc/v1/publish/, tid=95b461f, clientip=10.0.0.86, app=261-4/user-4, stream=, offer=5637B, eip=, codec=
2022-05-19T03:30:07.064130811Z [2022-05-19 03:30:07.063][Trace][1][5uq4a393] ignore attribute=, value=
2022-05-19T03:30:07.066229227Z [2022-05-19 03:30:07.065][Trace][1][5uq4a393] RTC publisher nack=1, nnc=1, pt-drop=0, twcc=1/3
2022-05-19T03:30:07.066269802Z [2022-05-19 03:30:07.065][Trace][1][5uq4a393] RTC: Init tracks {track: 94dbfc17-8767-4feb-b425-a45d58e92243, is_active: 0=>1},{track: 2989fcc3-47f8-470e-b771-b30671791eb9, is_active: 0=>1}, ok
2022-05-19T03:30:07.066314045Z [2022-05-19 03:30:07.066][Trace][1][5uq4a393] RTC: Use candidates 10.8.1.25
2022-05-19T03:30:07.066918345Z [2022-05-19 03:30:07.066][Trace][1][5uq4a393] RTC init session, user=62816c89:jkul, url=/261-4/user-4/, encrypt=1/1, DTLS(role=passive, version=auto), timeout=30000ms, nack=1
2022-05-19T03:30:07.066960033Z [2022-05-19 03:30:07.066][Trace][1][5uq4a393] RTC username=62816c89:jkul, offer=5637B, answer=1439B
2022-05-19T03:30:07.067259797Z [2022-05-19 03:30:07.066][Trace][1][5uq4a393] RTC remote offer: v=0\r\no=- 8090916585625035821 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:jkul\r\na=ice-pwd:SZKUtK3j4YzC+Xejx5pgy5Sq\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:2A:3F:83:A8:12:81:25:19:E5:7A:8C:C3:E9:0A:5A:EE:E6:E7:0A:1F:B0:BC:82:A3:99:73:AD:5D:63:66:7F\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:- 2989fcc3-47f8-470e-b771-b30671791eb9\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104 ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112 telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:4231672226 cname:uCnhijy6FTiL5CSZ\r\na=ssrc:4231672226 msid:- 2989fcc3-47f8-470e-b771-b30671791eb9\r\na=ssrc:4231672226 mslabel:-\r\na=ssrc:4231672226 label:2989fcc3-47f8-470e-b771-b30671791eb9\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 121 127 120 125 107 108 109 35 36 124 119 123 118 114 115 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:jkul\r\na=ice-pwd:SZKUtK3j4YzC+Xejx5pgy5Sq\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:2A:3F:83:A8:12:81:25:19:E5:7A:8C:C3:E9:0A:5A:EE:E6:E7:0A:1F:B0:BC:82:A3:99:73:AD:5D:63:66:7F\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13 urn:3gpp:video-orientation\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:- 94dbfc17-8767-4feb-b425-a45d58e92243\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98 VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98 transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98 nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:100 VP9/90000\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100 profile-id=2\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102 goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:121 rtx/90000\r\na=fmtp:121 apt=102\r\na=rtpmap:127 H264/90000\r\na=rtcp-fb:127 goog-remb\r\na=rtcp-fb:127 transport-cc\r\na=rtcp-fb:127 ccm fir\r\na=rtcp-fb:127 nack\r\na=rtcp-fb:127 nack pli\r\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\r\na=rtpmap:120 rtx/90000\r\na=fmtp:120 apt=127\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 goog-remb\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 ccm fir\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:108 H264/90000\r\na=rtcp-fb:108 goog-remb\r\na=rtcp-fb:108 transport-cc\r\na=rtcp-fb:108 ccm fir\r\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109 rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:35 AV1X/90000\r\na=rtcp-fb:35 goog-remb\r\na=rtcp-fb:35 transport-cc\r\na=rtcp-fb:35 ccm fir\r\na=rtcp-fb:35 nack\r\na=rtcp-fb:35 nack pli\r\na=rtpmap:36 rtx/90000\r\na=fmtp:36 apt=35\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124 goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d001f\r\na=rtpmap:119 rtx/90000\r\na=fmtp:119 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123 goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=64001f\r\na=rtpmap:118 rtx/90000\r\na=fmtp:118 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116 ulpfec/90000\r\na=ssrc-group:FID 2893223797 847711387\r\na=ssrc:2893223797 cname:uCnhijy6FTiL5CSZ\r\na=ssrc:2893223797 msid:- 94dbfc17-8767-4feb-b425-a45d58e92243\r\na=ssrc:2893223797 mslabel:-\r\na=ssrc:2893223797 label:94dbfc17-8767-4feb-b425-a45d58e92243\r\na=ssrc:847711387 cname:uCnhijy6FTiL5CSZ\r\na=ssrc:847711387 msid:- 94dbfc17-8767-4feb-b425-a45d58e92243\r\na=ssrc:847711387 mslabel:-\r\na=ssrc:847711387 label:94dbfc17-8767-4feb-b425-a45d58e92243\r\n
2022-05-19T03:30:07.067428942Z [2022-05-19 03:30:07.066][Trace][1][5uq4a393] RTC local answer: v=0\r\no=SRS/4.0.231(Leo) 23124240 2 IN IP4 0.0.0.0\r\ns=SRSPublishSession\r\nt=0 0\r\na=ice-lite\r\na=group:BUNDLE 0 1\r\na=msid-semantic: WMS 261-4/user-4/\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:62816c89\r\na=ice-pwd:27955o77ih31x5o3f9a3k6150290l833\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:0\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\nm=video 9 UDP/TLS/RTP/SAVPF 125 114\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:62816c89\r\na=ice-pwd:27955o77ih31x5o3f9a3k6150290l833\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:1\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\n
2022-05-19T03:30:07.071812227Z [2022-05-19 03:30:07.071][Trace][1][5uq4a393] TCP: before dispose resource(HttpConn)(0x1640390), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:30:07.071859184Z [33m[2022-05-19 03:30:07.071][Warn][1][5uq4a393][104] client disconnect peer. ret=1007
2022-05-19T03:30:07.071873271Z [0m[2022-05-19 03:30:07.071][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:30:07.071884491Z [2022-05-19 03:30:07.071][Trace][1][5uq4a393] TCP: disposing #0 resource(HttpConn)(0x1640390), conns=3, disposing=1, zombies=0
2022-05-19T03:30:07.124506166Z [2022-05-19 03:30:07.124][Trace][1][5uq4a393] RTC: session address init 10.0.0.86:53898
2022-05-19T03:30:07.124706604Z [2022-05-19 03:30:07.124][Trace][1][5uq4a393] RTC: session STUN done, waiting DTLS handshake.
2022-05-19T03:30:07.127913137Z [2022-05-19 03:30:07.127][Trace][1][5uq4a393] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=159, cnt=22, size=146, hs=1
2022-05-19T03:30:07.128569172Z [2022-05-19 03:30:07.128][Trace][1][5uq4a393] DTLS: State Passive SEND, done=0, arq=0/0, r0=-1, r1=2, len=681, cnt=22, size=82, hs=2
2022-05-19T03:30:07.131031090Z [2022-05-19 03:30:07.130][Trace][1][53cu8107] HTTP #1352 10.0.0.8:56616 GET http://10.8.1.25:1985/api/v1/streams/?callback=angular.callbacks._259, content-length=-1
2022-05-19T03:30:07.132406626Z [2022-05-19 03:30:07.132][Trace][1][5uq4a393] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=577, cnt=22, size=299, hs=11
2022-05-19T03:30:07.133891218Z [2022-05-19 03:30:07.133][Trace][1][5uq4a393] DTLS: State Passive SEND, done=1, arq=0/0, r0=1, r1=0, len=554, cnt=22, size=466, hs=4
2022-05-19T03:30:07.133951803Z [2022-05-19 03:30:07.133][Trace][1][5uq4a393] RTC: DTLS handshake done.
2022-05-19T03:30:07.134159277Z [2022-05-19 03:30:07.133][Trace][1][5uq4a393] RTC: session pub=1, sub=0, to=30000ms connection established
2022-05-19T03:30:07.134200888Z [2022-05-19 03:30:07.133][Trace][1][5uq4a393] RTC: Publisher url=/261-4/user-4/ established
2022-05-19T03:30:07.734195106Z [2022-05-19 03:30:07.733][Trace][1][i0z03797] <- RTC RECV #10, udp 45, pps 7/4, schedule 45
2022-05-19T03:30:08.830714986Z [2022-05-19 03:30:08.830][Trace][1][92m98j1y] HTTP #18 10.0.0.86:50426 GET http://10.8.1.25:1985/api/v1/clients/?callback=angular.callbacks._6, content-length=-1
2022-05-19T03:30:09.706815172Z [2022-05-19 03:30:09.706][Trace][1][2jec4033] HTTP #0 10.0.0.84:64822 POST http://10.8.1.25:1985/rtc/v1/play/, content-length=5672
2022-05-19T03:30:09.707273150Z [2022-05-19 03:30:09.707][Trace][1][2jec4033] RTC play webrtc://10.8.1.25/261-4/user-4/, api=http://10.8.1.25:1985/rtc/v1/play/, tid=4a255e2, clientip=10.0.0.84, app=261-4/user-4, stream=, offer=5210B, eip=, codec=, srtp=, dtls=
2022-05-19T03:30:09.707310443Z [2022-05-19 03:30:09.707][Trace][1][2jec4033] ignore attribute=, value=
2022-05-19T03:30:09.709342497Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC player nack=1, nnc=1
2022-05-19T03:30:09.709383588Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC connection player gcc=3
2022-05-19T03:30:09.709396990Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC: Init tracks {track: 94dbfc17-8767-4feb-b425-a45d58e92243, is_active: 0=>1},{track: 2989fcc3-47f8-470e-b771-b30671791eb9, is_active: 0=>1}, ok
2022-05-19T03:30:09.709411028Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC: Use candidates 10.8.1.25
2022-05-19T03:30:09.710013582Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC init session, user=6n0587s3:ovwi, url=/261-4/user-4/, encrypt=1/1, DTLS(role=passive, version=auto), timeout=30000ms, nack=1
2022-05-19T03:30:09.710181270Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC username=6n0587s3:ovwi, dtls=1, srtp=1, offer=5210B, answer=1804B
2022-05-19T03:30:09.710356525Z [2022-05-19 03:30:09.709][Trace][1][2jec4033] RTC remote offer: v=0\r\no=- 254580435049208329 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:ovwi\r\na=ice-pwd:mlW6b4TItj3WrA+wlgCImSRk\r\na=ice-options:trickle\r\na=fingerprint:sha-256 52:92:15:69:70:88:F6:7F:DF:F1:95:AF:AA:FE:60:D4:6D:3C:51:05:29:89:84:5C:22:06:DC:DD:72:D0:44:80\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104 ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112 telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107 108 109 35 36 124 119 123 118 114 115 116 37\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:ovwi\r\na=ice-pwd:mlW6b4TItj3WrA+wlgCImSRk\r\na=ice-options:trickle\r\na=fingerprint:sha-256 52:92:15:69:70:88:F6:7F:DF:F1:95:AF:AA:FE:60:D4:6D:3C:51:05:29:89:84:5C:22:06:DC:DD:72:D0:44:80\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13 urn:3gpp:video-orientation\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98 VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98 transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98 nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:100 VP9/90000\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100 profile-id=2\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:122 VP9/90000\r\na=rtcp-fb:122 goog-remb\r\na=rtcp-fb:122 transport-cc\r\na=rtcp-fb:122 ccm fir\r\na=rtcp-fb:122 nack\r\na=rtcp-fb:122 nack pli\r\na=fmtp:122 profile-id=1\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102 goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:121 rtx/90000\r\na=fmtp:121 apt=102\r\na=rtpmap:127 H264/90000\r\na=rtcp-fb:127 goog-remb\r\na=rtcp-fb:127 transport-cc\r\na=rtcp-fb:127 ccm fir\r\na=rtcp-fb:127 nack\r\na=rtcp-fb:127 nack pli\r\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\r\na=rtpmap:120 rtx/90000\r\na=fmtp:120 apt=127\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 goog-remb\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 ccm fir\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:108 H264/90000\r\na=rtcp-fb:108 goog-remb\r\na=rtcp-fb:108 transport-cc\r\na=rtcp-fb:108 ccm fir\r\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109 rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:35 AV1X/90000\r\na=rtcp-fb:35 goog-remb\r\na=rtcp-fb:35 transport-cc\r\na=rtcp-fb:35 ccm fir\r\na=rtcp-fb:35 nack\r\na=rtcp-fb:35 nack pli\r\na=rtpmap:36 rtx/90000\r\na=fmtp:36 apt=35\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124 goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0032\r\na=rtpmap:119 rtx/90000\r\na=fmtp:119 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123 goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640032\r\na=rtpmap:118 rtx/90000\r\na=fmtp:118 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116 ulpfec/90000\r\na=rtpmap:37 flexfec-03/90000\r\na=rtcp-fb:37 goog-remb\r\na=rtcp-fb:37 transport-cc\r\na=fmtp:37 repair-window=10000000\r\n
2022-05-19T03:30:09.710477534Z [2022-05-19 03:30:09.710][Trace][1][2jec4033] RTC local answer: v=0\r\no=SRS/4.0.231(Leo) 23866560 2 IN IP4 0.0.0.0\r\ns=SRSPlaySession\r\nt=0 0\r\na=ice-lite\r\na=group:BUNDLE 0 1\r\na=msid-semantic: WMS 261-4/user-4/\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:6n0587s3\r\na=ice-pwd:710n4l774l38568l21r4208256m6057d\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:0\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=sendonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=ssrc:10314 cname:053q6r9j35s4149k\r\na=ssrc:10314 msid:- 2989fcc3-47f8-470e-b771-b30671791eb9\r\na=ssrc:10314 mslabel:-\r\na=ssrc:10314 label:2989fcc3-47f8-470e-b771-b30671791eb9\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\nm=video 9 UDP/TLS/RTP/SAVPF 125 114\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:6n0587s3\r\na=ice-pwd:710n4l774l38568l21r4208256m6057d\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:1\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=sendonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=ssrc:10315 cname:053q6r9j35s4149k\r\na=ssrc:10315 msid:- 94dbfc17-8767-4feb-b425-a45d58e92243\r\na=ssrc:10315 mslabel:-\r\na=ssrc:10315 label:94dbfc17-8767-4feb-b425-a45d58e92243\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\n
2022-05-19T03:30:09.712467877Z [2022-05-19 03:30:09.712][Trace][1][2jec4033] TCP: before dispose resource(HttpConn)(0x15f4d10), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:30:09.712509781Z [33m[2022-05-19 03:30:09.712][Warn][1][2jec4033][104] client disconnect peer. ret=1007
2022-05-19T03:30:09.712523403Z [0m[2022-05-19 03:30:09.712][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:30:09.712534385Z [2022-05-19 03:30:09.712][Trace][1][2jec4033] TCP: disposing #0 resource(HttpConn)(0x15f4d10), conns=3, disposing=1, zombies=0
2022-05-19T03:30:09.756130461Z [2022-05-19 03:30:09.755][Trace][1][85ltr9u9] HTTP #0 10.0.0.84:64823 POST http://10.8.1.25:1985/rtc/v1/publish/, content-length=6117
2022-05-19T03:30:09.756316785Z [2022-05-19 03:30:09.756][Trace][1][85ltr9u9] RTC publish webrtc://10.8.1.25/261-4/user-261/, api=http://10.8.1.25:1985/rtc/v1/publish/, tid=7b69752, clientip=10.0.0.84, app=261-4/user-261, stream=, offer=5642B, eip=, codec=
2022-05-19T03:30:09.756456536Z [2022-05-19 03:30:09.756][Trace][1][85ltr9u9] ignore attribute=, value=
2022-05-19T03:30:09.758468799Z [2022-05-19 03:30:09.758][Trace][1][85ltr9u9] RTC publisher nack=1, nnc=1, pt-drop=0, twcc=1/3
2022-05-19T03:30:09.758507814Z [2022-05-19 03:30:09.758][Trace][1][85ltr9u9] RTC: Init tracks {track: 30c4beb4-dae4-4842-a2ae-6d81e202f4e6, is_active: 0=>1},{track: a4e448cf-bf3f-4d7d-aa65-b5598dd1d9a6, is_active: 0=>1}, ok
2022-05-19T03:30:09.758523586Z [2022-05-19 03:30:09.758][Trace][1][85ltr9u9] RTC: Use candidates 10.8.1.25
2022-05-19T03:30:09.759167033Z [2022-05-19 03:30:09.758][Trace][1][85ltr9u9] RTC init session, user=lmr68676:9OfL, url=/261-4/user-261/, encrypt=1/1, DTLS(role=passive, version=auto), timeout=30000ms, nack=1
2022-05-19T03:30:09.759207473Z [2022-05-19 03:30:09.758][Trace][1][85ltr9u9] RTC username=lmr68676:9OfL, offer=5642B, answer=1441B
2022-05-19T03:30:09.759609934Z [2022-05-19 03:30:09.759][Trace][1][85ltr9u9] RTC remote offer: v=0\r\no=- 7184607240867016300 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:9OfL\r\na=ice-pwd:IQrrgAwLTCihk70y7puweqmM\r\na=ice-options:trickle\r\na=fingerprint:sha-256 D6:8A:64:1C:BB:64:A2:AD:73:87:2D:83:D5:2C:65:8E:1A:EB:7C:A2:81:07:65:81:49:E1:3D:B8:53:79:0E:4B\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:- a4e448cf-bf3f-4d7d-aa65-b5598dd1d9a6\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104 ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112 telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:4018929198 cname:gqVcbQ1TVKJ/N2nU\r\na=ssrc:4018929198 msid:- a4e448cf-bf3f-4d7d-aa65-b5598dd1d9a6\r\na=ssrc:4018929198 mslabel:-\r\na=ssrc:4018929198 label:a4e448cf-bf3f-4d7d-aa65-b5598dd1d9a6\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 121 127 120 125 107 108 109 35 36 124 119 123 118 114 115 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:9OfL\r\na=ice-pwd:IQrrgAwLTCihk70y7puweqmM\r\na=ice-options:trickle\r\na=fingerprint:sha-256 D6:8A:64:1C:BB:64:A2:AD:73:87:2D:83:D5:2C:65:8E:1A:EB:7C:A2:81:07:65:81:49:E1:3D:B8:53:79:0E:4B\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13 urn:3gpp:video-orientation\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=sendonly\r\na=msid:- 30c4beb4-dae4-4842-a2ae-6d81e202f4e6\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98 VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98 transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98 nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:100 VP9/90000\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100 profile-id=2\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102 goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:121 rtx/90000\r\na=fmtp:121 apt=102\r\na=rtpmap:127 H264/90000\r\na=rtcp-fb:127 goog-remb\r\na=rtcp-fb:127 transport-cc\r\na=rtcp-fb:127 ccm fir\r\na=rtcp-fb:127 nack\r\na=rtcp-fb:127 nack pli\r\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\r\na=rtpmap:120 rtx/90000\r\na=fmtp:120 apt=127\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 goog-remb\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 ccm fir\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:108 H264/90000\r\na=rtcp-fb:108 goog-remb\r\na=rtcp-fb:108 transport-cc\r\na=rtcp-fb:108 ccm fir\r\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109 rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:35 AV1X/90000\r\na=rtcp-fb:35 goog-remb\r\na=rtcp-fb:35 transport-cc\r\na=rtcp-fb:35 ccm fir\r\na=rtcp-fb:35 nack\r\na=rtcp-fb:35 nack pli\r\na=rtpmap:36 rtx/90000\r\na=fmtp:36 apt=35\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124 goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0032\r\na=rtpmap:119 rtx/90000\r\na=fmtp:119 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123 goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640032\r\na=rtpmap:118 rtx/90000\r\na=fmtp:118 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116 ulpfec/90000\r\na=ssrc-group:FID 2317845790 3913300806\r\na=ssrc:2317845790 cname:gqVcbQ1TVKJ/N2nU\r\na=ssrc:2317845790 msid:- 30c4beb4-dae4-4842-a2ae-6d81e202f4e6\r\na=ssrc:2317845790 mslabel:-\r\na=ssrc:2317845790 label:30c4beb4-dae4-4842-a2ae-6d81e202f4e6\r\na=ssrc:3913300806 cname:gqVcbQ1TVKJ/N2nU\r\na=ssrc:3913300806 msid:- 30c4beb4-dae4-4842-a2ae-6d81e202f4e6\r\na=ssrc:3913300806 mslabel:-\r\na=ssrc:3913300806 label:30c4beb4-dae4-4842-a2ae-6d81e202f4e6\r\n
2022-05-19T03:30:09.759744398Z [2022-05-19 03:30:09.759][Trace][1][85ltr9u9] RTC local answer: v=0\r\no=SRS/4.0.231(Leo) 24391920 2 IN IP4 0.0.0.0\r\ns=SRSPublishSession\r\nt=0 0\r\na=ice-lite\r\na=group:BUNDLE 0 1\r\na=msid-semantic: WMS 261-4/user-261/\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:lmr68676\r\na=ice-pwd:kle35250i1787ov3rb8g9031b45jozso\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:0\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\nm=video 9 UDP/TLS/RTP/SAVPF 125 114\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:lmr68676\r\na=ice-pwd:kle35250i1787ov3rb8g9031b45jozso\r\na=fingerprint:sha-256 E6:E0:37:1B:C5:A2:AC:B8:26:3A:F8:30:15:AB:9A:DC:DD:34:06:CD:46:B0:AA:35:51:01:55:CB:2E:A4:E2:D9\r\na=setup:passive\r\na=mid:1\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=candidate:0 1 udp 2130706431 10.8.1.25 8000 typ host generation 0\r\n
2022-05-19T03:30:09.761120893Z [2022-05-19 03:30:09.760][Trace][1][2jec4033] RTC: session address init 10.0.0.84:59302
2022-05-19T03:30:09.761417269Z [2022-05-19 03:30:09.760][Trace][1][2jec4033] RTC: session STUN done, waiting DTLS handshake.
2022-05-19T03:30:09.762004823Z [2022-05-19 03:30:09.761][Trace][1][85ltr9u9] TCP: before dispose resource(HttpConn)(0x168eea0), conns=3, zombies=0, ign=0, inz=0, ind=0
2022-05-19T03:30:09.762127540Z [33m[2022-05-19 03:30:09.761][Warn][1][85ltr9u9][104] client disconnect peer. ret=1007
2022-05-19T03:30:09.762149607Z [0m[2022-05-19 03:30:09.761][Trace][1][m0b37799] TCP: clear zombies=1 resources, conns=3, removing=0, unsubs=0
2022-05-19T03:30:09.762183671Z [2022-05-19 03:30:09.761][Trace][1][85ltr9u9] TCP: disposing #0 resource(HttpConn)(0x168eea0), conns=3, disposing=1, zombies=0
2022-05-19T03:30:09.762683646Z [2022-05-19 03:30:09.762][Trace][1][2jec4033] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=159, cnt=22, size=146, hs=1
2022-05-19T03:30:09.763723168Z [2022-05-19 03:30:09.763][Trace][1][2jec4033] DTLS: State Passive SEND, done=0, arq=0/0, r0=-1, r1=2, len=681, cnt=22, size=82, hs=2
2022-05-19T03:30:09.766338527Z [2022-05-19 03:30:09.765][Trace][1][2jec4033] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=578, cnt=22, size=299, hs=11
2022-05-19T03:30:09.768225790Z [2022-05-19 03:30:09.767][Trace][1][2jec4033] DTLS: State Passive SEND, done=1, arq=0/0, r0=1, r1=0, len=554, cnt=22, size=466, hs=4
2022-05-19T03:30:09.768270163Z [2022-05-19 03:30:09.767][Trace][1][2jec4033] RTC: DTLS handshake done.
2022-05-19T03:30:09.768454707Z [2022-05-19 03:30:09.768][Trace][1][2jec4033] RTC: session pub=0, sub=1, to=30000ms connection established
2022-05-19T03:30:09.768491920Z [2022-05-19 03:30:09.768][Trace][1][2jec4033] RTC: Subscriber url=/261-4/user-4/ established
2022-05-19T03:30:09.769012570Z [2022-05-19 03:30:09.768][Trace][1][2jec4033] create consumer, no gop cache
2022-05-19T03:30:09.769053933Z [2022-05-19 03:30:09.768][Trace][1][2jec4033] RTC: start play url=/261-4/user-4/, source_id=5uq4a393/ci9e59z7, realtime=1, mw_msgs=0
2022-05-19T03:30:09.911454541Z [2022-05-19 03:30:09.911][Trace][1][2jec4033] RTC: session address change 10.0.0.84:59302 -> 10.0.0.82:62777, cached=0, nn_change=1/1, nn_address=1
2022-05-19T03:30:09.929547262Z [2022-05-19 03:30:09.929][Trace][1][85ltr9u9] RTC: session address init 10.0.0.84:54356
2022-05-19T03:30:09.929562757Z [2022-05-19 03:30:09.929][Trace][1][85ltr9u9] RTC: session STUN done, waiting DTLS handshake.
2022-05-19T03:30:09.930912532Z [2022-05-19 03:30:09.930][Trace][1][85ltr9u9] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=159, cnt=22, size=146, hs=1
2022-05-19T03:30:09.931217083Z [2022-05-19 03:30:09.931][Trace][1][85ltr9u9] DTLS: State Passive SEND, done=0, arq=0/0, r0=-1, r1=2, len=681, cnt=22, size=82, hs=2
2022-05-19T03:30:09.933072801Z [2022-05-19 03:30:09.932][Trace][1][85ltr9u9] DTLS: State Passive RECV, done=0, arq=0/0, r0=1, r1=0, len=581, cnt=22, size=301, hs=11
2022-05-19T03:30:09.933626617Z [2022-05-19 03:30:09.933][Trace][1][85ltr9u9] DTLS: State Passive SEND, done=1, arq=0/0, r0=1, r1=0, len=554, cnt=22, size=466, hs=4
SRS Config(配置):
使用 docker 部署 srs 的默认配置
Replay(重现)
Please describe how to replay the bug? (重现Bug的步骤)
在 user-4 与其他用户进行一对一会话时复现此问题
user-4 使用的 windows11计算机开机，并打开音视频会议客户端
user-4 向其他用户发起会议，其他用户进入会议，此时其他用户听不到 user-4 的声音
此时打开 srs 控制台客户端，只显示 3 条流，缺少了 user-4 的推流
user-4结束会议并重新向其他用户发起会议，此时会议正常，双方都能听到对方的声音，srs 控制台中显示 4 条流
此后 user-4 发起的会议都能正常进行，直至 user-4 重启计算机
Expect(期望行为)
user-4 开机后第一发起会议时能成功推流，其他用户能听到 user-4 的声音
May 27 '22 00:05 YonLJ
Please use the simplest reproduction path, such as directly pushing WebRTC stream with SRS Player, can it reproduce?
TRANS_BY_GPT3
Jun 19 '22 03:06 winlinvip
srs srs copied to clipboard

WebRTC: 开机后第一次向 srs 推流失败

srs
srs copied to clipboard
