| 2026-10-28 01:15:57.008 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.46 minutes] elapsed › |
| 2026-10-28 01:15:56.860 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 87.128s 物品: 查询 2009 / 待处理 605 / 已处理 605 / 成功 605 / 失败 0 并发数: 6 历史归档: 735 吞吐量: 6.94 items/s 阶段耗时: - 查询待处理物品: 0.218s - KVrocks状态过滤: 0.137s - 历史数据归档: 0.293s - 订阅基础数据加载: 0.068s - 订阅规则加载: 1.011s - 历史推送价格加载: 0.155s - worker处理: 82.847s - 邮件发送: 2.398s 调用统计: - KVrocks状态写入: 605次, 累计 10.430s, 平均 0.017s, P50 0.012s, P95 0.038s, P99 0.097s, 最大 0.258s - itemdetail: 605次, 累计 13.752s, 平均 0.023s, P50 0.016s, P95 0.049s, P99 0.117s, 最大 0.461s - 估价: 605次, 累计 458.308s, 平均 0.758s, P50 0.497s, P95 2.165s, P99 4.401s, 最大 8.567s - 推送记录写入: 31次, 累计 2.794s, 平均 0.090s, P50 0.086s, P95 0.110s, P99 0.119s, 最大 0.201s - 物品描述解析: 240次, 累计 4.267s, 平均 0.018s, P50 0.013s, P95 0.044s, P99 0.069s, 最大 0.076s - 订阅匹配与推送: 605次, 累计 13.137s, 平均 0.022s, P50 0.014s, P95 0.077s, P99 0.151s, 最大 0.254s - 订阅规则匹配: 624次, 累计 4.391s, 平均 0.007s, P50 0.000s, P95 0.029s, P99 0.056s, 最大 0.077s worker负载: - worker 1: 95件, 忙碌 82.844s - worker 2: 110件, 忙碌 82.732s - worker 3: 97件, 忙碌 82.642s - worker 4: 91件, 忙碌 82.298s - worker 5: 95件, 忙碌 82.407s - worker 6: 117件, 忙碌 82.730s 最慢物品 Top 10: - eid=202610280000113-192-XYWH0TIQGVDZ, worker=4, 总耗时=8.617s, KVrocks状态写入=0.007s, itemdetail=0.025s, 估价=8.567s, 物品处理=8.617s, 订阅匹配与推送=0.018s - eid=202610280000113-459-9E0RACVWQ0S5, worker=3, 总耗时=5.905s, KVrocks状态写入=0.023s, itemdetail=0.010s, 估价=5.853s, 物品处理=5.905s, 物品描述解析=0.019s, 订阅匹配与推送=0.019s - eid=202610280000113-203-ZQJV9CWWV22F, worker=4, 总耗时=5.666s, KVrocks状态写入=0.018s, itemdetail=0.016s, 估价=5.620s, 物品处理=5.666s, 物品描述解析=0.012s, 订阅匹配与推送=0.012s - eid=202610280000113-199-O78W9ELYUKZN, worker=3, 总耗时=5.065s, KVrocks状态写入=0.027s, itemdetail=0.046s, 估价=4.982s, 物品处理=5.065s, 物品描述解析=0.009s, 订阅匹配与推送=0.010s - eid=202610280000113-807-HOEYMJQTBER2, worker=3, 总耗时=4.918s, KVrocks状态写入=0.008s, itemdetail=0.016s, 估价=4.889s, 物品处理=4.918s, 订阅匹配与推送=0.005s - eid=202610280000113-838-9SBRP6EAG1RQ, worker=1, 总耗时=4.895s, KVrocks状态写入=0.009s, itemdetail=0.049s, 估价=4.727s, 物品处理=4.895s, 订阅匹配与推送=0.110s - eid=202610280000113-584-POF3P8B3EQVI, worker=3, 总耗时=4.781s, KVrocks状态写入=0.008s, itemdetail=0.023s, 估价=4.722s, 物品处理=4.781s, 订阅匹配与推送=0.027s - eid=202610280000113-326-07C2W6DL0G1D, worker=3, 总耗时=4.479s, KVrocks状态写入=0.011s, itemdetail=0.059s, 估价=4.401s, 物品处理=4.479s, 订阅匹配与推送=0.009s - eid=202610280000113-192-IZHUXANKUMJM, worker=6, 总耗时=4.402s, KVrocks状态写入=0.019s, itemdetail=0.026s, 估价=4.344s, 物品处理=4.402s, 订阅匹配与推送=0.014s - eid=202610280000113-558-K8ZEWYGG7QEK, worker=4, 总耗时=4.326s, KVrocks状态写入=0.009s, itemdetail=0.010s, 估价=4.293s, 物品处理=4.326s, 物品描述解析=0.013s, 订阅匹配与推送=0.014s =========================================== › |
| 2026-10-28 01:15:56.860 · INFO · cbg-trade · test |
| [subcheck.go:376] [sub_check] completed: processed=605/605 waiting=0 ordered=0 pushed=31 errors=0 › |
| 2026-10-28 01:15:55.191 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.42 minutes] elapsed › |
| 2026-10-28 01:15:54.460 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=605/605 waiting=0 ordered=0 pushed=31 errors=0 › |
| 2026-10-28 01:15:53.914 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=600/605 waiting=0 ordered=0 pushed=31 errors=0 › |
| 2026-10-28 01:15:51.764 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610280100113-795-KNC92QI2I3BI server_id=795 reason=value status=1 status_code=OK kind_id=41 equip_type=3751 listing_status=2 › |
| 2026-10-28 01:15:44.508 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-10-28 01:15:43.960 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=500/605 waiting=0 ordered=0 pushed=25 errors=0 › |
| 2026-10-28 01:15:41.607 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.19 minutes] elapsed › |
| 2026-10-28 01:15:41.607 · INFO · cbg-trade · test |
| [update.go:176] updated 43/50 random push reviews › |
| 2026-10-28 01:15:41.607 · INFO · cbg-trade · test |
| [update.go:191] update success › |
| 2026-10-28 01:15:37.213 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.13 minutes] elapsed › |
| 2026-10-28 01:15:37.201 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 67.315s 角色: 查询 415 / 待处理 410 / 已处理 410 / 成功 410 / 失败 0 / 已标记 1 并发数: 9 吞吐量: 6.09 roles/s 阶段耗时: - 分布式锁: 0.032s - 查询待处理角色: 0.099s - KVrocks状态过滤: 0.024s - 特殊服务器配置加载: 0.000s - worker处理: 66.357s - OpenIM通知: 0.802s 调用统计: - KVrocks状态写入: 1次, 累计 0.032s, 平均 0.032s, P50 0.032s, P95 0.032s, P99 0.032s, 最大 0.032s - roledetail: 410次, 累计 391.724s, 平均 0.955s, P50 0.784s, P95 2.011s, P99 2.654s, 最大 8.871s - 基础抽签队列写入: 1次, 累计 0.023s, 平均 0.023s, P50 0.023s, P95 0.023s, P99 0.023s, 最大 0.023s - 审核记录写入: 1次, 累计 0.103s, 平均 0.103s, P50 0.103s, P95 0.103s, P99 0.103s, 最大 0.103s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 75次, 累计 113.197s, 平均 1.509s, P50 0.197s, P95 7.047s, P99 13.988s, 最大 14.351s 请求明细: - roledetail HTTP请求: 410 - roledetail首次成功: 410 worker负载: - worker 1: 48件, 忙碌 59.270s - worker 2: 52件, 忙碌 52.947s - worker 3: 49件, 忙碌 53.194s - worker 4: 43件, 忙碌 53.444s - worker 5: 59件, 忙碌 66.355s - worker 6: 43件, 忙碌 59.276s - worker 7: 38件, 忙碌 53.566s - worker 8: 42件, 忙碌 53.569s - worker 9: 36件, 忙碌 53.461s 最慢角色 Top 10: - eid=202610262300113-584-3EOCYQE2FD3Q, worker=6, 总耗时=15.204s, roledetail=1.216s, 角色估价=13.988s - eid=202610272300113-584-KV2YW43PTZYP, worker=5, 总耗时=15.054s, roledetail=0.703s, 角色估价=14.351s - eid=202610270000113-584-FJ1QM6B98CV2, worker=1, 总耗时=11.422s, roledetail=1.008s, 角色估价=10.414s - eid=202610280000113-584-TBXWNLJQLLTU, worker=9, 总耗时=9.782s, roledetail=1.335s, 角色估价=8.447s - eid=202610280000113-352-BAEB8YLMRIAT, worker=7, 总耗时=9.069s, roledetail=8.871s, 角色估价=0.197s - eid=202610280000113-584-8ETONC0YHTEC, worker=7, 总耗时=7.940s, roledetail=1.291s, 角色估价=6.648s - eid=202610272200113-159-SID2HARXNJLR, worker=4, 总耗时=7.727s, roledetail=0.679s, 角色估价=7.047s - eid=202610222300113-901-7EATU4ASG2WR, worker=8, 总耗时=6.428s, roledetail=1.295s, 角色估价=5.133s - eid=202610280000113-132-XQHLPDHPYEZN, worker=8, 总耗时=6.117s, roledetail=1.308s, 角色估价=4.809s - eid=202609161400113-527-DY21J4MIEBSH, worker=3, 总耗时=5.558s, roledetail=1.284s, 角色估价=4.274s =============================================== › |
| 2026-10-28 01:15:36.651 · INFO · cbg-trade · test |
| [clothes.go:50] Initialized clothes cache with 5632 items › |
| 2026-10-28 01:15:36.398 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 410/410 › |
| 2026-10-28 01:15:35.949 · INFO · cbg-trade · test |
| [update.go:140] [37/50] worker 1 check count 1, eid: 202610280000113-200-EXFQ8DQFIHIJ, status 2 › |
| 2026-10-28 01:15:35.846 · INFO · cbg-trade · test |
| [update.go:140] [43/50] worker 2 check count 1, eid: 202610272300113-9-PAQFDSK53JDEK7, status 2 › |
| 2026-10-28 01:15:35.846 · INFO · cbg-trade · test |
| [update.go:140] [42/50] worker 3 check count 1, eid: 202610272300113-459-LUQOH3QB0EJN, status 2 › |
| 2026-10-28 01:15:35.759 · INFO · cbg-trade · test |
| [update.go:140] [36/50] worker 4 check count 1, eid: 202610280000113-275-OZJ0B4D4KFS9, status 2 › |