| 2026-11-01 16:33:56.370 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.52 minutes] elapsed › |
| 2026-11-01 16:33:56.357 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 31.044s 角色: 查询 141 / 待处理 135 / 已处理 135 / 成功 135 / 失败 0 / 已标记 1 并发数: 8 吞吐量: 4.35 roles/s 阶段耗时: - 分布式锁: 0.006s - 查询待处理角色: 0.051s - KVrocks状态过滤: 0.008s - 特殊服务器配置加载: 0.000s - worker处理: 30.843s - OpenIM通知: 0.135s 调用统计: - KVrocks状态写入: 1次, 累计 0.007s, 平均 0.007s, P50 0.007s, P95 0.007s, P99 0.007s, 最大 0.007s - roledetail: 135次, 累计 125.558s, 平均 0.930s, P50 0.539s, P95 2.786s, P99 3.455s, 最大 3.864s - 基础抽签队列写入: 1次, 累计 0.026s, 平均 0.026s, P50 0.026s, P95 0.026s, P99 0.026s, 最大 0.026s - 审核记录写入: 1次, 累计 0.079s, 平均 0.079s, P50 0.079s, P95 0.079s, P99 0.079s, 最大 0.079s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 27次, 累计 95.179s, 平均 3.525s, P50 2.803s, P95 8.169s, P99 8.210s, 最大 10.673s 请求明细: - roledetail HTTP请求: 135 - roledetail首次成功: 135 worker负载: - worker 1: 20件, 忙碌 30.843s - worker 2: 21件, 忙碌 25.816s - worker 3: 12件, 忙碌 29.125s - worker 4: 19件, 忙碌 24.670s - worker 5: 15件, 忙碌 26.080s - worker 6: 13件, 忙碌 24.709s - worker 7: 19件, 忙碌 29.089s - worker 8: 16件, 忙碌 30.520s 最慢角色 Top 10: - eid=202609161200113-926-BGYVNBJQVM9D, worker=8, 总耗时=11.062s, roledetail=0.389s, 角色估价=10.673s - eid=202609010100113-9-X4Y00FNHTZJIVI, worker=6, 总耗时=10.719s, roledetail=2.550s, 角色估价=8.169s - eid=202610161500113-584-2UNLNPTUW53E, worker=2, 总耗时=8.789s, roledetail=0.579s, 角色估价=8.210s - eid=202610081400113-527-QNIY9VC3H8VC, worker=7, 总耗时=8.156s, roledetail=0.446s, 角色估价=7.710s - eid=202609161200113-926-I0GBVJ71NQUZ, worker=1, 总耗时=7.985s, roledetail=0.358s, 角色估价=7.627s - eid=202609161200113-926-RX27UXVV3IQN, worker=4, 总耗时=7.947s, roledetail=0.631s, 角色估价=7.316s - eid=202208220800113-527-RVVYQBD0VI8A, worker=3, 总耗时=7.014s, roledetail=0.379s, 角色估价=6.635s - eid=202609151200113-215-NMYGJBZCUKMW, worker=3, 总耗时=6.817s, roledetail=0.667s, 角色估价=6.150s - eid=202406291900113-926-L9BTXOHKWUEB, worker=1, 总耗时=6.459s, roledetail=2.488s, 角色估价=3.971s - eid=202609151200113-215-BDK6IY3LQQX2, worker=5, 总耗时=6.121s, roledetail=0.415s, 角色估价=5.706s =============================================== › |
| 2026-11-01 16:33:56.221 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 135/135 › |
| 2026-11-01 16:33:53.779 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611011600113-942-PFGR07O5CYQR server_id=942 reason=value status=1 status_code=OK kind_id=35 equip_type=3745 listing_status=2 › |
| 2026-11-01 16:33:53.689 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-01 16:33:47.811 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=100/138 waiting=0 ordered=0 pushed=4 errors=0 › |
| 2026-11-01 16:33:45.565 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 100/135 › |
| 2026-11-01 16:33:43.323 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.30 minutes] elapsed › |
| 2026-11-01 16:33:42.149 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.28 minutes] elapsed › |
| 2026-11-01 16:33:40.928 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.26 minutes] elapsed › |
| 2026-11-01 16:33:39.692 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.24 minutes] elapsed › |
| 2026-11-01 16:33:39.374 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610301100113-443-ZHOJC5WXS86Q server_id=443 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-11-01 16:33:39.081 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.24 minutes] elapsed › |
| 2026-11-01 16:33:39.081 · INFO · cbg-trade · test |
| [report.go:167] ========== RandomDraw 汇总与性能分析报告 ========== 结果: success_with_errors 总耗时: 13.921s 停止原因: checkpoint 请求服务: cbg-item-detail 页面: 尝试 5 / 成功 5 / 失败 0 数据: 处理 71 / 新增 63 / 重复 8 / 时间过滤 0 / 归档 63 Mailbox: 成功 63 / 失败 63 吞吐量: 5.10 items/s, 0.36 pages/s 异常: 请求 0 / 解析 0 / 状态异常 0 / 密保 0 / 无代理 0 / 致命 0 最后错误: mailbox Mailbox:RoleFlow is full (size: 100000) 阶段耗时: - 加载抓取配置: 0.097s - 分页抓取: 13.050s - 历史归档: 0.241s - 保存Checkpoint: 0.132s - 保存运行统计: 0.211s - 发送通知: 0.190s 调用统计: - Mailbox写入: 126次, 累计 2.520s, 平均 0.020s, P50 0.016s, P95 0.049s, P99 0.065s, 最大 0.073s - 批量写入: 5次, 累计 0.409s, 平均 0.082s, P50 0.079s, P95 0.085s, P99 0.085s, 最大 0.096s - 批量去重查询: 5次, 累计 0.124s, 平均 0.025s, P50 0.024s, P95 0.026s, P99 0.026s, 最大 0.028s - 角色列表服务请求: 5次, 累计 8.541s, 平均 1.708s, P50 2.099s, P95 2.396s, P99 2.396s, 最大 2.747s 最慢页面 Top 5: - page=3, 总耗时=3.913s, 获取=2.747s, 处理=1.166s - page=2, 总耗时=3.303s, 获取=2.397s, 处理=0.906s - page=4, 总耗时=3.067s, 获取=2.099s, 处理=0.968s - page=1, 总耗时=1.426s, 获取=0.482s, 处理=0.944s - page=5, 总耗时=1.328s, 获取=0.816s, 处理=0.511s ================================================== › |
| 2026-11-01 16:33:38.298 · INFO · cbg-trade · test |
| [update_role_push.go:27] update role random push success › |
| 2026-11-01 16:33:38.298 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.22 minutes] elapsed › |
| 2026-11-01 16:33:38.297 · INFO · cbg-trade · test |
| [update.go:141] updated 4/11 role random push reviews › |
| 2026-11-01 16:33:38.297 · ERROR · cbg-trade · test |
| [update.go:115] [11/11] role worker 1 failed to get role detail, eid: 202610022200113-12-X1PU32NTRKFHY, server_id: 12, bad_eid: 0, err: detail service: UPSTREAM_ERROR (HTTP 502) › |
| 2026-11-01 16:33:36.899 · INFO · cbg-trade · test |
| [update.go:107] [11/11] role worker 1 check count 2, eid: 202610022200113-12-X1PU32NTRKFHY › |
| 2026-11-01 16:33:36.899 · ERROR · cbg-trade · test |
| [update.go:115] [10/11] role worker 1 failed to get role detail, eid: 202610072200113-197-SMMZM1MEIOYC, server_id: 197, bad_eid: 0, err: detail service: UPSTREAM_ERROR (HTTP 502) › |