| 2026-10-23 15:12:09.876 · INFO · cbg-trade · test |
| [update.go:107] [5/14] role worker 1 check count 2, eid: 202609230900113-326-JAOIA1KTFDOC › |
| 2026-10-23 15:12:09.711 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610231500113-857-LWD3RVG2DBOT server_id=857 reason=value status=1 status_code=OK kind_id=36 equip_type=3746 listing_status=2 › |
| 2026-10-23 15:12:09.358 · INFO · cbg-trade · test |
| [update.go:107] [4/14] role worker 1 check count 2, eid: 202605032200113-527-YHMTS3PGACDJ › |
| 2026-10-23 15:12:09.332 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.85 minutes] elapsed › |
| 2026-10-23 15:12:09.325 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 50.493s 角色: 查询 473 / 待处理 449 / 已处理 449 / 成功 448 / 失败 1 / 已标记 1 并发数: 9 吞吐量: 8.89 roles/s 阶段耗时: - 分布式锁: 0.005s - 查询待处理角色: 0.078s - KVrocks状态过滤: 0.017s - 特殊服务器配置加载: 0.000s - worker处理: 50.242s - OpenIM通知: 0.152s 调用统计: - KVrocks状态写入: 1次, 累计 0.007s, 平均 0.007s, P50 0.007s, P95 0.007s, P99 0.007s, 最大 0.007s - roledetail: 449次, 累计 320.917s, 平均 0.715s, P50 0.589s, P95 1.556s, P99 2.026s, 最大 4.457s - 基础抽签队列写入: 1次, 累计 0.017s, 平均 0.017s, P50 0.017s, P95 0.017s, P99 0.017s, 最大 0.017s - 审核记录写入: 1次, 累计 0.309s, 平均 0.309s, P50 0.309s, P95 0.309s, P99 0.309s, 最大 0.309s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 69次, 累计 108.448s, 平均 1.572s, P50 0.726s, P95 4.060s, P99 7.905s, 最大 9.974s 请求明细: - roledetail HTTP请求: 452 - roledetail重试: 4 - roledetail重试成功: 4 - roledetail首次成功: 444 worker负载: - worker 1: 44件, 忙碌 47.028s - worker 2: 43件, 忙碌 47.167s - worker 3: 58件, 忙碌 47.441s - worker 4: 48件, 忙碌 47.160s - worker 5: 57件, 忙碌 47.503s - worker 6: 38件, 忙碌 50.240s - worker 7: 51件, 忙碌 47.247s - worker 8: 56件, 忙碌 47.689s - worker 9: 54件, 忙碌 48.226s 最慢角色 Top 10: - eid=202609291100113-352-HT65D1CA5LKB, worker=2, 总耗时=10.481s, roledetail=0.507s, 角色估价=9.974s - eid=202610221400113-407-BOH2KPUVQISI, worker=6, 总耗时=8.805s, roledetail=0.899s, 角色估价=7.905s - eid=202609061800113-132-LXVJ23YOQISY, worker=4, 总耗时=7.705s, roledetail=1.116s, 角色估价=6.588s - eid=202610051400113-407-YEWK4Q750MZR, worker=8, 总耗时=7.293s, roledetail=0.743s, 角色估价=6.550s - eid=202610231400113-60-H3YE3ZM9LWNT1, worker=4, 总耗时=5.430s, roledetail=1.872s, 角色估价=3.558s - eid=202608201900113-554-YARVLOR74DZS, worker=6, 总耗时=4.698s, roledetail=0.638s, 角色估价=4.060s - eid=202610211500113-926-IM79FKUBYO3Q, worker=6, 总耗时=4.626s, roledetail=0.786s, 角色估价=3.839s - eid=202610221600113-26-VC08OZU6Q35XR, worker=1, 总耗时=4.457s, roledetail=4.457s - eid=202610171800113-527-4FYTOMJTC0JY, worker=1, 总耗时=4.256s, roledetail=0.394s, 角色估价=3.862s - eid=202610141700113-730-5M01YTLQRFLY, worker=5, 总耗时=4.220s, roledetail=0.844s, 角色估价=3.376s 错误汇总: - roledetail: 1 - 角色处理: 1 =============================================== › |
| 2026-10-23 15:12:09.173 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 449/449 › |
| 2026-10-23 15:12:07.207 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610231500113-821-MTYYSEZBT1VJ server_id=821 reason=value status=1 status_code=OK kind_id=36 equip_type=3746 listing_status=2 › |
| 2026-10-23 15:12:06.205 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610231500113-821-KDV0DLB9LMLF server_id=821 reason=value status=1 status_code=OK kind_id=36 equip_type=3746 listing_status=2 › |
| 2026-10-23 15:12:05.965 · INFO · cbg-trade · test |
| [update.go:107] [3/14] role worker 1 check count 0, eid: 202610231000113-799-4N2WACWE7LHD › |
| 2026-10-23 15:12:05.270 · INFO · cbg-trade · test |
| [update.go:107] [2/14] role worker 1 check count 0, eid: 202610231400113-982-9TZ8NHF7UB22 › |
| 2026-10-23 15:12:04.754 · INFO · cbg-trade · test |
| [update.go:139] updating 14 role random push reviews with 1 workers › |
| 2026-10-23 15:12:04.754 · INFO · cbg-trade · test |
| [update.go:107] [1/14] role worker 1 check count 0, eid: 202610231400113-669-NSMI1YWCXTWY › |
| 2026-10-23 15:12:04.709 · INFO · cbg-trade · test |
| [update.go:67] role random push stats: total=3148, check_count<3=1304, distribution: 0=6, 1=3, 2=1295, 3=1844 › |
| 2026-10-23 15:12:04.691 · INFO · cbg-trade · test |
| [report.go:167] ========== RandomDraw 汇总与性能分析报告 ========== 结果: success_with_errors 总耗时: 36.864s 停止原因: checkpoint 请求服务: cbg-item-detail 页面: 尝试 26 / 成功 26 / 失败 0 数据: 处理 375 / 新增 280 / 重复 95 / 时间过滤 0 / 归档 197 Mailbox: 成功 113 / 失败 280 吞吐量: 10.17 items/s, 0.71 pages/s 异常: 请求 0 / 解析 0 / 状态异常 0 / 密保 0 / 无代理 0 / 致命 0 最后错误: mailbox Mailbox:RoleFlow is full (size: 100000) 阶段耗时: - 加载抓取配置: 0.104s - 分页抓取: 36.089s - 历史归档: 0.262s - 保存Checkpoint: 0.098s - 保存运行统计: 0.153s - 发送通知: 0.159s 调用统计: - Mailbox写入: 393次, 累计 8.455s, 平均 0.022s, P50 0.015s, P95 0.056s, P99 0.115s, 最大 0.269s - 批量写入: 25次, 累计 2.146s, 平均 0.086s, P50 0.076s, P95 0.085s, P99 0.085s, 最大 0.319s - 批量去重查询: 26次, 累计 0.671s, 平均 0.026s, P50 0.025s, P95 0.027s, P99 0.030s, 最大 0.043s - 角色列表服务请求: 26次, 累计 17.194s, 平均 0.661s, P50 0.451s, P95 1.710s, P99 1.925s, 最大 2.178s 最慢页面 Top 10: - page=1, 总耗时=3.181s, 获取=1.925s, 处理=1.256s - page=24, 总耗时=2.845s, 获取=2.178s, 处理=0.667s - page=4, 总耗时=2.280s, 获取=1.710s, 处理=0.570s - page=22, 总耗时=1.866s, 获取=0.429s, 处理=1.437s - page=6, 总耗时=1.864s, 获取=0.494s, 处理=1.371s - page=8, 总耗时=1.598s, 获取=0.362s, 处理=1.236s - page=2, 总耗时=1.552s, 获取=0.419s, 处理=1.133s - page=7, 总耗时=1.500s, 获取=0.411s, 处理=1.090s - page=23, 总耗时=1.425s, 获取=0.411s, 处理=1.014s - page=16, 总耗时=1.350s, 获取=0.451s, 处理=0.899s ================================================== › |
| 2026-10-23 15:12:04.691 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.62 minutes] elapsed › |
| 2026-10-23 15:12:04.673 · INFO · cbg-trade · test |
| [netstub.go:24] Starting net stub on port 9346... › |
| 2026-10-23 15:12:04.673 · INFO · cbg-trade · test |
| [update_role_push.go:25] update role random push, concurrency: 1 › |
| 2026-10-23 15:12:04.672 · INFO · cbg-trade · test |
| [clickhouse.go:67] ClickHouse connected successfully, database=cbg_item host=192.168.101.203 port=9000 › |
| 2026-10-23 15:12:04.625 · INFO · cbg-trade · test |
| [database.go:732] mysql connection pool configured: MaxOpenConns=50, MaxIdleConns=10, ConnMaxLifetime=300s › |
| 2026-10-23 15:12:04.470 · INFO · cbg-trade · test |
| [database.go:694] mysql connecting to 124.220.31.60:3306/cbg as root › |