| 2026-11-11 10:35:03.466 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 66.556s 角色: 查询 298 / 待处理 293 / 已处理 293 / 成功 289 / 失败 4 / 已标记 1 并发数: 8 吞吐量: 4.40 roles/s 阶段耗时: - 分布式锁: 0.066s - 查询待处理角色: 0.151s - KVrocks状态过滤: 0.060s - 特殊服务器配置加载: 0.000s - worker处理: 65.306s - OpenIM通知: 0.973s 调用统计: - KVrocks状态写入: 1次, 累计 0.023s, 平均 0.023s, P50 0.023s, P95 0.023s, P99 0.023s, 最大 0.023s - roledetail: 293次, 累计 248.740s, 平均 0.849s, P50 0.729s, P95 1.777s, P99 2.762s, 最大 3.185s - 基础抽签队列写入: 1次, 累计 0.112s, 平均 0.112s, P50 0.112s, P95 0.112s, P99 0.112s, 最大 0.112s - 审核记录写入: 1次, 累计 0.136s, 平均 0.136s, P50 0.136s, P95 0.136s, P99 0.136s, 最大 0.136s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 69次, 累计 213.375s, 平均 3.092s, P50 1.205s, P95 10.768s, P99 17.707s, 最大 28.939s 请求明细: - roledetail HTTP请求: 292 - roledetail首次成功: 289 worker负载: - worker 1: 40件, 忙碌 57.180s - worker 2: 44件, 忙碌 54.379s - worker 3: 25件, 忙碌 65.303s - worker 4: 31件, 忙碌 54.722s - worker 5: 43件, 忙碌 59.842s - worker 6: 31件, 忙碌 61.507s - worker 7: 49件, 忙碌 54.997s - worker 8: 30件, 忙碌 54.458s 最慢角色 Top 10: - eid=202611081700113-527-RKQNTBF3ZPD5, worker=3, 总耗时=30.070s, roledetail=1.131s, 角色估价=28.939s - eid=202611111000113-926-JNVN3JYYQ8UU, worker=8, 总耗时=18.618s, roledetail=0.912s, 角色估价=17.707s - eid=202611041400113-527-IKO6UNXUAZX9, worker=6, 总耗时=12.545s, roledetail=1.777s, 角色估价=10.768s - eid=202611111000113-105-NY3JVQSDJSDL, worker=1, 总耗时=12.447s, KVrocks状态写入=0.023s, roledetail=0.554s, 基础抽签队列写入=0.112s, 审核记录写入=0.136s, 服务器查询=0.000s, 角色估价=11.623s - eid=202611110900113-926-M6COAZEECZPR, worker=2, 总耗时=12.289s, roledetail=1.125s, 角色估价=11.164s - eid=202611111000113-926-SQXNAYYACJQ5, worker=4, 总耗时=11.725s, roledetail=1.213s, 角色估价=10.512s - eid=202608082300113-527-VQPE5KLKJV4B, worker=4, 总耗时=10.034s, roledetail=0.681s, 角色估价=9.353s - eid=202611050100113-584-GU4UXN0OVWU6, worker=5, 总耗时=8.623s, roledetail=0.558s, 角色估价=8.065s - eid=202610271900113-527-P0D1UW6W9IOF, worker=8, 总耗时=8.204s, roledetail=1.162s, 角色估价=7.043s - eid=202608031300113-926-8O00JHA9ZYIO, worker=6, 总耗时=7.957s, roledetail=0.794s, 角色估价=7.163s 错误汇总: - roledetail: 4 - 角色处理: 4 =============================================== › |
| 2026-11-11 10:35:03.417 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=711 dropped=0 › |
| 2026-11-11 10:35:02.492 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 293/293 › |
| 2026-11-11 10:34:59.971 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111000113-527-5EUIDVTYTPUD server_id=527 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=33 equip_type=3743 listing_status=2 › |
| 2026-11-11 10:34:56.806 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111000113-326-DYBXKNLTFNVQ server_id=326 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=40 equip_type=3750 listing_status=2 › |
| 2026-11-11 10:34:52.817 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.47 minutes] elapsed › |
| 2026-11-11 10:34:51.816 · INFO · cbg-trade · test |
| [subcheck.go:429] [sub_check] completed: processed=309/309 waiting=0 ordered=0 pushed=17 errors=2 › |
| 2026-11-11 10:34:51.815 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 85.816s 物品: 查询 1794 / 待处理 309 / 已处理 309 / 成功 307 / 失败 2 并发数: 4 历史归档: 766 吞吐量: 3.60 items/s 阶段耗时: - 查询待处理物品: 0.160s - KVrocks状态过滤: 0.057s - 历史数据归档: 0.344s - 订阅基础数据加载: 0.096s - 订阅规则加载: 1.246s - 订阅候选粗筛: 0.007s - 历史推送价格加载: 0.053s - worker处理: 81.625s - 邮件发送: 2.227s 调用统计: - KVrocks状态写入: 307次, 累计 10.398s, 平均 0.034s, P50 0.020s, P95 0.092s, P99 0.263s, 最大 0.324s - itemdetail: 309次, 累计 142.987s, 平均 0.463s, P50 0.378s, P95 0.899s, P99 1.469s, 最大 2.239s - 估价: 307次, 累计 157.381s, 平均 0.513s, P50 0.432s, P95 1.023s, P99 1.601s, 最大 2.856s - 推送记录写入: 17次, 累计 3.219s, 平均 0.189s, P50 0.150s, P95 0.389s, P99 0.389s, 最大 0.439s - 物品描述解析: 121次, 累计 6.104s, 平均 0.050s, P50 0.035s, P95 0.124s, P99 0.244s, 最大 0.734s - 订阅匹配与推送: 307次, 累计 14.742s, 平均 0.048s, P50 0.025s, P95 0.206s, P99 0.381s, 最大 0.734s - 订阅规则匹配: 320次, 累计 6.169s, 平均 0.019s, P50 0.000s, P95 0.076s, P99 0.143s, 最大 0.734s worker负载: - worker 1: 76件, 忙碌 81.623s - worker 2: 79件, 忙碌 80.969s - worker 3: 82件, 忙碌 81.431s - worker 4: 72件, 忙碌 81.505s 最慢物品 Top 10: - eid=202611111000113-192-5LOWQ0DJ5NDX, worker=4, 总耗时=4.463s, KVrocks状态写入=0.011s, itemdetail=1.572s, 估价=2.856s, 物品处理=4.463s, 订阅匹配与推送=0.022s - eid=202611111000113-681-O0EF6B2RCDWI, worker=2, 总耗时=3.003s, KVrocks状态写入=0.043s, itemdetail=0.652s, 估价=2.294s, 物品处理=3.003s, 订阅匹配与推送=0.014s - eid=202611111000113-33-GCEFHRM4H6YV2, worker=1, 总耗时=2.948s, KVrocks状态写入=0.050s, itemdetail=1.441s, 估价=0.895s, 物品处理=2.948s, 物品描述解析=0.124s, 订阅匹配与推送=0.563s - eid=202611111000113-443-LXJSV3LUD6DJ, worker=1, 总耗时=2.749s, KVrocks状态写入=0.008s, itemdetail=1.248s, 估价=1.493s, 物品处理=2.749s, 订阅匹配与推送=0.000s - eid=202611110900113-527-B9GCQ6620B55, worker=4, 总耗时=2.594s, KVrocks状态写入=0.047s, itemdetail=2.239s, 估价=0.284s, 物品处理=2.594s, 订阅匹配与推送=0.024s - eid=202611111000113-901-IJS5FSJBDTJK, worker=2, 总耗时=2.475s, KVrocks状态写入=0.017s, itemdetail=1.624s, 估价=0.798s, 物品处理=2.475s, 订阅匹配与推送=0.036s - eid=202611111000113-9-XS9L5P8AFA1ZPS, worker=2, 总耗时=2.465s, KVrocks状态写入=0.013s, itemdetail=0.431s, 估价=1.601s, 物品处理=2.465s, 订阅匹配与推送=0.419s - eid=202611111000113-681-6RLRMOAWIUSW, worker=4, 总耗时=2.448s, KVrocks状态写入=0.007s, itemdetail=1.916s, 估价=0.512s, 物品处理=2.448s, 订阅匹配与推送=0.013s - eid=202611111000113-40-MGJFYHAULXS0H, worker=3, 总耗时=2.438s, KVrocks状态写入=0.028s, itemdetail=1.051s, 估价=0.911s, 物品处理=2.438s, 订阅匹配与推送=0.448s - eid=202611111000113-305-QQBE5HFXF7S1, worker=3, 总耗时=2.301s, KVrocks状态写入=0.013s, itemdetail=1.469s, 估价=0.758s, 物品处理=2.301s, 订阅匹配与推送=0.062s 错误汇总: - itemdetail: 2 - 物品处理: 2 =========================================== › |
| 2026-11-11 10:34:49.587 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=309/309 waiting=0 ordered=0 pushed=17 errors=2 › |
| 2026-11-11 10:34:47.476 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/309 waiting=0 ordered=0 pushed=17 errors=2 › |
| 2026-11-11 10:34:45.252 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-11 10:34:39.804 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111000113-804-GYAHX7V1HA9T server_id=804 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=40 equip_type=3750 listing_status=2 › |
| 2026-11-11 10:34:37.648 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111000113-558-QM8ECYRFQAZL server_id=558 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=49 equip_type=997 listing_status=2 › |
| 2026-11-11 10:34:37.400 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 200/293 › |
| 2026-11-11 10:34:33.416 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=709 dropped=0 › |
| 2026-11-11 10:34:32.422 · ERROR · cbg-trade · test |
| [single_line.go:43] new role check failed, eid=202507131600113-894-3RFUHWNOZOVK: detail service: INVALID_INPUT (HTTP 400) › |
| 2026-11-11 10:34:28.814 · INFO · cbg-trade · test |
| [update.go:73] update random push review finished › |
| 2026-11-11 10:34:28.814 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.08 minutes] elapsed › |
| 2026-11-11 10:34:28.814 · INFO · cbg-trade · test |
| [update.go:58] random push review: scanned_eids=3 requests=3 cooldown_skipped=0 failed=0 updated_rows=3 › |
| 2026-11-11 10:34:27.675 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111000113-1034-MPEC3BPCA5P server_id=1034 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=36 equip_type=3746 listing_status=2 › |