| 2026-10-31 15:34:23.458 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.98 minutes] elapsed › |
| 2026-10-31 15:34:22.809 · INFO · cbg-trade · test |
| [subcheck.go:376] [sub_check] completed: processed=307/307 waiting=0 ordered=0 pushed=22 errors=0 › |
| 2026-10-31 15:34:22.809 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 58.190s 物品: 查询 1328 / 待处理 307 / 已处理 307 / 成功 307 / 失败 0 并发数: 4 历史归档: 547 吞吐量: 5.28 items/s 阶段耗时: - 查询待处理物品: 0.111s - KVrocks状态过滤: 0.042s - 历史数据归档: 0.262s - 订阅基础数据加载: 0.056s - 订阅规则加载: 0.657s - 历史推送价格加载: 0.062s - worker处理: 53.568s - 邮件发送: 3.432s 调用统计: - KVrocks状态写入: 307次, 累计 2.611s, 平均 0.009s, P50 0.007s, P95 0.015s, P99 0.027s, 最大 0.055s - itemdetail: 307次, 累计 7.481s, 平均 0.024s, P50 0.011s, P95 0.024s, P99 0.258s, 最大 1.434s - 估价: 307次, 累计 197.657s, 平均 0.644s, P50 0.387s, P95 2.200s, P99 3.775s, 最大 5.237s - 推送记录写入: 22次, 累计 1.581s, 平均 0.072s, P50 0.071s, P95 0.074s, P99 0.076s, 最大 0.077s - 物品描述解析: 99次, 累计 0.937s, 平均 0.009s, P50 0.009s, P95 0.017s, P99 0.021s, 最大 0.026s - 订阅匹配与推送: 307次, 累计 4.100s, 平均 0.013s, P50 0.008s, P95 0.078s, P99 0.092s, 最大 0.156s - 订阅规则匹配: 269次, 累计 0.986s, 平均 0.004s, P50 0.000s, P95 0.014s, P99 0.020s, 最大 0.028s worker负载: - worker 1: 76件, 忙碌 52.863s - worker 2: 69件, 忙碌 53.566s - worker 3: 81件, 忙碌 52.634s - worker 4: 81件, 忙碌 52.797s 最慢物品 Top 10: - eid=202610311500113-732-NXFXEFXHKTHK, worker=4, 总耗时=5.275s, KVrocks状态写入=0.007s, itemdetail=0.020s, 估价=5.237s, 物品处理=5.275s, 订阅匹配与推送=0.011s - eid=202610311500113-104-NP3WIP9CNXS1, worker=2, 总耗时=4.966s, KVrocks状态写入=0.008s, itemdetail=0.014s, 估价=4.937s, 物品处理=4.966s, 订阅匹配与推送=0.007s - eid=202610311500113-807-UR9CP9UXFM4P, worker=2, 总耗时=4.180s, KVrocks状态写入=0.005s, itemdetail=0.010s, 估价=4.160s, 物品处理=4.180s, 订阅匹配与推送=0.006s - eid=202610311500113-40-S9A7INSTILIPH, worker=4, 总耗时=4.078s, KVrocks状态写入=0.008s, itemdetail=0.013s, 估价=4.050s, 物品处理=4.078s, 订阅匹配与推送=0.008s - eid=202610311500113-935-GURW006SL5YT, worker=1, 总耗时=3.806s, KVrocks状态写入=0.006s, itemdetail=0.014s, 估价=3.775s, 物品处理=3.806s, 订阅匹配与推送=0.011s - eid=202610301400113-920-FHYGOWJQGWE2, worker=2, 总耗时=3.388s, KVrocks状态写入=0.010s, itemdetail=1.394s, 估价=1.977s, 物品处理=3.388s, 订阅匹配与推送=0.008s - eid=202610311400113-26-5LT1LALN6NDM3, worker=2, 总耗时=2.908s, KVrocks状态写入=0.009s, itemdetail=1.434s, 估价=1.459s, 物品处理=2.908s, 订阅匹配与推送=0.007s - eid=202610311400113-407-LHEHOIOOIMYP, worker=1, 总耗时=2.904s, KVrocks状态写入=0.007s, itemdetail=0.007s, 估价=2.874s, 物品处理=2.904s, 订阅匹配与推送=0.016s - eid=202610311400113-77-FWHNTPLTBBMGH, worker=2, 总耗时=2.835s, KVrocks状态写入=0.008s, itemdetail=0.009s, 估价=2.805s, 物品处理=2.835s, 订阅匹配与推送=0.014s - eid=202610311400113-3-RDKCIQ640KWMQX, worker=2, 总耗时=2.651s, KVrocks状态写入=0.008s, itemdetail=0.016s, 估价=2.615s, 物品处理=2.651s, 订阅匹配与推送=0.011s =========================================== › |
| 2026-10-31 15:34:22.684 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311500113-96-N894LHAIFBUK2 server_id=96 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-10-31 15:34:21.366 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311500113-138-VY2FRAIEVLFZ server_id=138 reason=value status=1 status_code=OK kind_id=38 equip_type=3748 listing_status=2 › |
| 2026-10-31 15:34:19.376 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=307/307 waiting=0 ordered=0 pushed=22 errors=0 › |
| 2026-10-31 15:34:18.019 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/307 waiting=0 ordered=0 pushed=22 errors=0 › |
| 2026-10-31 15:34:11.470 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311500113-1041-YRQPCH15I4G server_id=1041 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-10-31 15:34:09.264 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202406051600113-40-7WQ54VERFKOM5 server_id=40 reason=value status=1 status_code=OK kind_id=33 equip_type=3743 listing_status=2 › |
| 2026-10-31 15:34:09.010 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.74 minutes] elapsed › |
| 2026-10-31 15:34:09.004 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 44.164s 角色: 查询 165 / 待处理 165 / 已处理 165 / 成功 165 / 失败 0 / 已标记 1 并发数: 8 吞吐量: 3.74 roles/s 阶段耗时: - 分布式锁: 0.016s - 查询待处理角色: 1.688s - KVrocks状态过滤: 0.024s - 特殊服务器配置加载: 0.000s - worker处理: 41.976s - OpenIM通知: 0.460s 调用统计: - KVrocks状态写入: 1次, 累计 0.009s, 平均 0.009s, P50 0.009s, P95 0.009s, P99 0.009s, 最大 0.009s - roledetail: 165次, 累计 205.823s, 平均 1.247s, P50 0.725s, P95 3.438s, P99 5.275s, 最大 11.917s - 基础抽签队列写入: 1次, 累计 0.018s, 平均 0.018s, P50 0.018s, P95 0.018s, P99 0.018s, 最大 0.018s - 审核记录写入: 1次, 累计 0.080s, 平均 0.080s, P50 0.080s, P95 0.080s, P99 0.080s, 最大 0.080s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 40次, 累计 89.037s, 平均 2.226s, P50 0.454s, P95 8.653s, P99 9.666s, 最大 10.978s 请求明细: - roledetail HTTP请求: 172 - roledetail重试: 7 - roledetail重试成功: 7 - roledetail首次成功: 158 worker负载: - worker 1: 22件, 忙碌 41.975s - worker 2: 13件, 忙碌 38.696s - worker 3: 16件, 忙碌 40.688s - worker 4: 28件, 忙碌 33.360s - worker 5: 16件, 忙碌 33.318s - worker 6: 22件, 忙碌 33.647s - worker 7: 25件, 忙碌 39.349s - worker 8: 23件, 忙碌 33.934s 最慢角色 Top 10: - eid=202609021000113-199-9JPUYPHDMMO9, worker=3, 总耗时=11.917s, roledetail=11.917s - eid=202610311400113-60-ZHPQGJW00BDGG, worker=3, 总耗时=11.703s, roledetail=0.725s, 角色估价=10.978s - eid=202607092100113-554-T5MUP4E2CE9U, worker=1, 总耗时=11.414s, roledetail=1.748s, 角色估价=9.666s - eid=202610210500113-352-KBLDT5DFNLSW, worker=2, 总耗时=9.061s, roledetail=0.408s, 角色估价=8.653s - eid=202610301800113-584-KVYVS8UMYMMS, worker=1, 总耗时=7.983s, roledetail=0.587s, 角色估价=7.396s - eid=202610302300113-39-AHJD6TXVWXXHR, worker=7, 总耗时=7.398s, KVrocks状态写入=0.009s, roledetail=0.899s, 基础抽签队列写入=0.018s, 审核记录写入=0.080s, 服务器查询=0.000s, 角色估价=6.393s - eid=202604231500113-926-ANW9ZB4BJSCS, worker=4, 总耗时=6.640s, roledetail=0.509s, 角色估价=6.131s - eid=202610271400113-527-B1ME5GBCOISI, worker=7, 总耗时=6.056s, roledetail=0.517s, 角色估价=5.539s - eid=202610311400113-132-ZG3I0HARWX9M, worker=5, 总耗时=5.945s, roledetail=5.908s, 角色估价=0.038s - eid=202610211800113-926-52D81VBXHMEK, worker=2, 总耗时=5.816s, roledetail=0.862s, 角色估价=4.954s =============================================== › |
| 2026-10-31 15:34:08.543 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 165/165 › |
| 2026-10-31 15:34:05.590 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610311500113-192-XEZ1CZJSDJRI server_id=192 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-10-31 15:34:05.050 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-10-31 15:34:03.880 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=2997 dropped=6 › |
| 2026-10-31 15:34:02.760 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=200/307 waiting=0 ordered=0 pushed=12 errors=0 › |
| 2026-10-31 15:34:00.831 · INFO · cbg-trade · test |
| [clothes.go:50] Initialized clothes cache with 5634 items › |
| 2026-10-31 15:33:59.003 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.57 minutes] elapsed › |
| 2026-10-31 15:33:58.056 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 87 items › |
| 2026-10-31 15:33:58.030 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 87 items › |