| 2026-10-31 18:04:23.007 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.97 minutes] elapsed › |
| 2026-10-31 18:04:23.000 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 57.954s 角色: 查询 157 / 待处理 155 / 已处理 155 / 成功 154 / 失败 1 / 已标记 0 并发数: 8 吞吐量: 2.67 roles/s 阶段耗时: - 分布式锁: 0.010s - 查询待处理角色: 0.070s - KVrocks状态过滤: 0.009s - 特殊服务器配置加载: 0.000s - worker处理: 57.729s - OpenIM通知: 0.136s 调用统计: - roledetail: 155次, 累计 373.370s, 平均 2.409s, P50 1.347s, P95 7.631s, P99 11.776s, 最大 17.937s - 角色估价: 22次, 累计 38.588s, 平均 1.754s, P50 0.205s, P95 5.506s, P99 7.526s, 最大 11.523s 请求明细: - roledetail HTTP请求: 162 - roledetail重试: 8 - roledetail重试成功: 8 - roledetail首次成功: 146 worker负载: - worker 1: 19件, 忙碌 49.898s - worker 2: 20件, 忙碌 50.270s - worker 3: 12件, 忙碌 57.727s - worker 4: 16件, 忙碌 51.775s - worker 5: 11件, 忙碌 50.272s - worker 6: 22件, 忙碌 50.649s - worker 7: 28件, 忙碌 50.370s - worker 8: 27件, 忙碌 51.000s 最慢角色 Top 10: - eid=202601212100113-12-FXZHXEGFSQUUN, worker=4, 总耗时=17.937s, roledetail=17.937s - eid=202610192000113-459-LWX9ATZYHYZ5, worker=5, 总耗时=13.668s, roledetail=13.668s - eid=202610262200113-926-UORKWRHJLLUK, worker=3, 总耗时=12.942s, roledetail=1.419s, 角色估价=11.523s - eid=202607170800113-769-YRQ2088POJWO, worker=3, 总耗时=11.776s, roledetail=11.776s - eid=202610311700113-712-EHNCIDX8IZSF, worker=1, 总耗时=11.242s, roledetail=11.242s - eid=202610311700113-527-3YZMVY82JRG7, worker=2, 总耗时=10.389s, roledetail=2.863s, 角色估价=7.526s - eid=202610311700113-901-OMQ2VJQKRUCT, worker=8, 总耗时=10.071s, roledetail=10.046s, 角色估价=0.024s - eid=202610311700113-352-VENQWGFT7QEU, worker=5, 总耗时=9.479s, roledetail=9.436s, 角色估价=0.043s - eid=202610061300113-953-WHTRJG5ZF9EZ, worker=8, 总耗时=8.400s, roledetail=8.400s - eid=202610201300113-1000-KL4LNI5CLLE, worker=1, 总耗时=8.347s, roledetail=8.347s 错误汇总: - roledetail: 1 - 角色处理: 1 =============================================== › |
| 2026-10-31 18:04:22.864 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 155/155 › |
| 2026-10-31 18:04:20.604 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.93 minutes] elapsed › |
| 2026-10-31 18:04:19.148 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=500/741 waiting=0 ordered=0 pushed=34 errors=0 › |
| 2026-10-31 18:04:17.841 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.89 minutes] elapsed › |
| 2026-10-31 18:04:17.456 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311800113-407-9GFCZ1X44FL4 server_id=407 reason=value status=1 status_code=OK kind_id=34 equip_type=3744 listing_status=2 › |
| 2026-10-31 18:04:17.306 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: LEFB-KLNO-1775-9446 › |
| 2026-10-31 18:04:14.485 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311800113-527-AN88QULQK72J server_id=527 reason=value status=1 status_code=OK kind_id=36 equip_type=3746 listing_status=2 › |
| 2026-10-31 18:04:12.156 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311800113-558-00GY0HD1BYXW server_id=558 reason=value status=1 status_code=OK kind_id=39 equip_type=3749 listing_status=2 › |
| 2026-10-31 18:04:09.874 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=400/741 waiting=0 ordered=0 pushed=30 errors=0 › |
| 2026-10-31 18:04:08.287 · INFO · cbg-trade · test |
| [update.go:191] update success › |
| 2026-10-31 18:04:08.287 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.73 minutes] elapsed › |
| 2026-10-31 18:04:08.287 · INFO · cbg-trade · test |
| [update.go:176] updated 61/68 random push reviews › |
| 2026-10-31 18:04:08.220 · INFO · cbg-trade · test |
| [update.go:140] [67/68] worker 2 check count 2, eid: 202610241700113-901-WTBFMGLPFZLH, status 2 › |
| 2026-10-31 18:04:07.939 · INFO · cbg-trade · test |
| [update.go:142] [65/68] worker 4 check count 2, eid: 202610241700113-3-OFUNL7F6IVNQDY, status 2->6 › |
| 2026-10-31 18:04:07.760 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311800113-558-RRARFWURUA4T server_id=558 reason=value status=1 status_code=OK kind_id=39 equip_type=3749 listing_status=2 › |
| 2026-10-31 18:04:06.796 · INFO · cbg-trade · test |
| [update.go:142] [68/68] worker 1 check count 2, eid: 202610241700113-579-EKQRPII0OLQC, status 2->0 › |
| 2026-10-31 18:04:06.735 · INFO · cbg-trade · test |
| [update.go:140] [63/68] worker 3 check count 2, eid: 202610241700113-976-EHHME0CRTLT1, status 2 › |
| 2026-10-31 18:04:06.556 · INFO · cbg-trade · test |
| [update.go:142] [64/68] worker 1 check count 2, eid: 202610241700113-926-V2NTM0CB88KW, status 2->6 › |