| 2026-11-10 22:14:49.453 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.42 minutes] elapsed › |
| 2026-11-10 22:14:49.345 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.87 minutes] elapsed › |
| 2026-11-10 22:14:49.318 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 51.822s 角色: 查询 230 / 待处理 227 / 已处理 227 / 成功 226 / 失败 1 / 已标记 1 并发数: 8 吞吐量: 4.38 roles/s 阶段耗时: - 分布式锁: 0.049s - 查询待处理角色: 0.062s - KVrocks状态过滤: 0.086s - 特殊服务器配置加载: 0.000s - worker处理: 51.053s - OpenIM通知: 0.571s 调用统计: - KVrocks状态写入: 1次, 累计 0.016s, 平均 0.016s, P50 0.016s, P95 0.016s, P99 0.016s, 最大 0.016s - roledetail: 227次, 累计 202.539s, 平均 0.892s, P50 0.786s, P95 1.660s, P99 2.079s, 最大 3.294s - 基础抽签队列写入: 1次, 累计 0.135s, 平均 0.135s, P50 0.135s, P95 0.135s, P99 0.135s, 最大 0.135s - 审核记录写入: 1次, 累计 0.138s, 平均 0.138s, P50 0.138s, P95 0.138s, P99 0.138s, 最大 0.138s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 46次, 累计 183.403s, 平均 3.987s, P50 2.749s, P95 11.851s, P99 13.011s, 最大 14.436s 请求明细: - roledetail HTTP请求: 226 - roledetail首次成功: 226 worker负载: - worker 1: 13件, 忙碌 46.341s - worker 2: 28件, 忙碌 46.731s - worker 3: 32件, 忙碌 48.900s - worker 4: 37件, 忙碌 46.740s - worker 5: 26件, 忙碌 48.675s - worker 6: 32件, 忙碌 50.840s - worker 7: 26件, 忙碌 46.955s - worker 8: 33件, 忙碌 51.052s 最慢角色 Top 10: - eid=202611090100113-215-YQAVUMDYQKRK, worker=1, 总耗时=14.993s, roledetail=0.556s, 角色估价=14.436s - eid=202611090100113-215-B1HUINT2JRPC, worker=4, 总耗时=13.639s, roledetail=0.628s, 角色估价=13.011s - eid=202611090100113-215-VLZ6WMLQNVPO, worker=5, 总耗时=12.719s, roledetail=0.867s, 角色估价=11.851s - eid=202610010900113-554-UAF6CK6WX2ZI, worker=3, 总耗时=12.550s, roledetail=0.676s, 角色估价=11.874s - eid=202611090100113-215-5ARFH84QYW8B, worker=2, 总耗时=10.657s, roledetail=0.604s, 角色估价=10.053s - eid=202611051100113-554-2VAF0U73MUT3, worker=2, 总耗时=10.150s, roledetail=0.825s, 角色估价=9.325s - eid=202611102100113-285-AJZCOK59UWOG, worker=1, 总耗时=9.292s, KVrocks状态写入=0.016s, roledetail=1.106s, 基础抽签队列写入=0.135s, 审核记录写入=0.138s, 服务器查询=0.000s, 角色估价=7.897s - eid=202605310800113-215-QLIDNZ5T25YG, worker=8, 总耗时=9.139s, roledetail=1.008s, 角色估价=8.131s - eid=202610241800113-926-PCDOUKUEPSNA, worker=5, 总耗时=9.099s, roledetail=1.038s, 角色估价=8.061s - eid=202611102100113-730-X80NQH4L4TKN, worker=7, 总耗时=8.874s, roledetail=0.704s, 角色估价=8.170s 错误汇总: - roledetail: 1 - 角色处理: 1 =============================================== › |
| 2026-11-10 22:14:48.746 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 227/227 › |
| 2026-11-10 22:14:48.207 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/426 waiting=0 ordered=0 pushed=13 errors=3 › |
| 2026-11-10 22:14:47.703 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-10 22:14:47.393 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611102200113-199-GEUAJGBGCSNZ server_id=199 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=50 equip_type=998 listing_status=2 › |
| 2026-11-10 22:14:43.227 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611102200113-935-QMECLFZAJYLZ server_id=935 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=81 equip_type=52784 listing_status=2 › |
| 2026-11-10 22:14:37.357 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 200/227 › |
| 2026-11-10 22:14:34.832 · INFO · cbg-trade · test |
| [clothes.go:50] Initialized clothes cache with 5642 items › |
| 2026-11-10 22:14:33.620 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=3495 dropped=27 › |
| 2026-11-10 22:14:29.977 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611102200113-105-H0DFULEFQC2B server_id=105 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=31 equip_type=3741 listing_status=2 › |
| 2026-11-10 22:14:26.020 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.03 minutes] elapsed › |
| 2026-11-10 22:14:26.020 · INFO · cbg-trade · test |
| [update.go:73] update random push review finished › |
| 2026-11-10 22:14:26.019 · INFO · cbg-trade · test |
| [update.go:58] random push review: scanned_eids=6 requests=5 cooldown_skipped=1 failed=0 updated_rows=5 › |
| 2026-11-10 22:14:24.550 · INFO · cbg-trade · test |
| [netstub.go:24] Starting net stub on port 9340... › |
| 2026-11-10 22:14:24.550 · INFO · cbg-trade · test |
| [clickhouse.go:67] ClickHouse connected successfully, database=cbg_item host=192.168.101.203 port=9000 › |
| 2026-11-10 22:14:24.550 · INFO · cbg-trade · test |
| [update.go:71] update randomPushReview: concurrency: 4, limit: 800 › |
| 2026-11-10 22:14:24.456 · INFO · cbg-trade · test |
| [database.go:733] mysql connection pool configured: MaxOpenConns=50, MaxIdleConns=10, ConnMaxLifetime=300s › |
| 2026-11-10 22:14:24.181 · INFO · cbg-trade · test |
| [database.go:695] mysql connecting to 124.220.31.60:3306/cbg as cbg-trade › |