| 2026-10-25 13:31:06.459 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 96.303s 物品: 查询 1692 / 待处理 538 / 已处理 538 / 成功 538 / 失败 0 并发数: 5 历史归档: 825 吞吐量: 5.59 items/s 阶段耗时: - 查询待处理物品: 0.144s - KVrocks状态过滤: 0.067s - 历史数据归档: 0.322s - 订阅基础数据加载: 0.073s - 订阅规则加载: 0.830s - 历史推送价格加载: 0.114s - worker处理: 92.316s - 邮件发送: 2.437s 调用统计: - KVrocks状态写入: 538次, 累计 6.465s, 平均 0.012s, P50 0.009s, P95 0.023s, P99 0.046s, 最大 0.140s - itemdetail: 538次, 累计 8.974s, 平均 0.017s, P50 0.013s, P95 0.037s, P99 0.059s, 最大 0.166s - 估价: 538次, 累计 430.936s, 平均 0.801s, P50 0.448s, P95 2.832s, P99 4.236s, 最大 7.966s - 推送记录写入: 29次, 累计 2.654s, 平均 0.092s, P50 0.074s, P95 0.093s, P99 0.326s, 最大 0.327s - 物品描述解析: 230次, 累计 3.311s, 平均 0.014s, P50 0.011s, P95 0.034s, P99 0.055s, 最大 0.088s - 订阅匹配与推送: 538次, 累计 9.965s, 平均 0.019s, P50 0.011s, P95 0.078s, P99 0.124s, 最大 0.392s - 订阅规则匹配: 572次, 累计 3.419s, 平均 0.006s, P50 0.000s, P95 0.022s, P99 0.048s, 最大 0.088s worker负载: - worker 1: 106件, 忙碌 92.312s - worker 2: 125件, 忙碌 90.794s - worker 3: 105件, 忙碌 90.900s - worker 4: 90件, 忙碌 91.599s - worker 5: 112件, 忙碌 90.758s 最慢物品 Top 10: - eid=202610251200113-443-VYHUYXZZ8EKU, worker=1, 总耗时=8.030s, KVrocks状态写入=0.007s, itemdetail=0.045s, 估价=7.966s, 物品处理=8.030s, 订阅匹配与推送=0.011s - eid=202610251200113-149-A0LJRB82KZET, worker=1, 总耗时=7.324s, KVrocks状态写入=0.011s, itemdetail=0.010s, 估价=7.282s, 物品处理=7.324s, 订阅匹配与推送=0.021s - eid=202610251200113-3-N8UW9R7MNPRYWA, worker=1, 总耗时=6.066s, KVrocks状态写入=0.009s, itemdetail=0.018s, 估价=6.039s, 物品处理=6.066s, 订阅匹配与推送=0.000s - eid=202610251200113-976-AP9M6F6NCGD2, worker=4, 总耗时=5.839s, KVrocks状态写入=0.009s, itemdetail=0.008s, 估价=5.815s, 物品处理=5.839s, 物品描述解析=0.007s, 订阅匹配与推送=0.007s - eid=202610251200113-138-I2CDIOOVB30L, worker=3, 总耗时=5.047s, KVrocks状态写入=0.027s, itemdetail=0.011s, 估价=4.975s, 物品处理=5.047s, 物品描述解析=0.033s, 订阅匹配与推送=0.033s - eid=202610251200113-911-H80H3DAZISVU, worker=3, 总耗时=4.931s, KVrocks状态写入=0.010s, itemdetail=0.022s, 估价=4.892s, 物品处理=4.931s, 物品描述解析=0.007s, 订阅匹配与推送=0.007s - eid=202610251200113-657-XE9N2QXU4GQM, worker=5, 总耗时=4.274s, KVrocks状态写入=0.006s, itemdetail=0.013s, 估价=4.236s, 物品处理=4.274s, 订阅匹配与推送=0.019s - eid=202610251200113-367-UBC9XVTF6ADU, worker=5, 总耗时=4.114s, KVrocks状态写入=0.008s, itemdetail=0.025s, 估价=3.999s, 物品处理=4.114s, 订阅匹配与推送=0.082s - eid=202610251200113-334-LPGZT7FSYSVI, worker=4, 总耗时=4.096s, KVrocks状态写入=0.008s, itemdetail=0.019s, 估价=4.061s, 物品处理=4.096s, 订阅匹配与推送=0.008s - eid=202610251200113-1000-3UW0SZN3JJX, worker=5, 总耗时=4.072s, KVrocks状态写入=0.008s, itemdetail=0.014s, 估价=4.041s, 物品处理=4.072s, 订阅匹配与推送=0.009s =========================================== › |
| 2026-10-25 13:31:05.840 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=2124 dropped=0 › |
| 2026-10-25 13:31:05.000 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202503031900113-443-HP4S7NQW5XOZ server_id=443 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-10-25 13:31:04.021 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=538/538 waiting=0 ordered=0 pushed=29 errors=0 › |
| 2026-10-25 13:31:01.522 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202412191100113-443-J5VFDJCSNVJM server_id=443 reason=value status=1 status_code=OK kind_id=82 equip_type=55970 listing_status=2 › |
| 2026-10-25 13:30:57.555 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=500/538 waiting=0 ordered=0 pushed=27 errors=0 › |
| 2026-10-25 13:30:54.716 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610251300113-199-HJJVA0VNMNLS server_id=199 reason=value status=1 status_code=OK kind_id=32 equip_type=3742 listing_status=2 › |
| 2026-10-25 13:30:50.207 · WARN · cbg-trade · test |
| [armor_report.go:119] omit init_damage_raw for ambiguous mixed weapon gems, eid=202610251200113-215-BX1RNBDKAVRJ › |
| 2026-10-25 13:30:49.609 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610251300113-200-CSIYTO0KCWNH server_id=200 reason=value status=1 status_code=OK kind_id=33 equip_type=3743 listing_status=2 › |
| 2026-10-25 13:30:48.692 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.31 minutes] elapsed › |
| 2026-10-25 13:30:48.684 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 76.243s 角色: 查询 463 / 待处理 445 / 已处理 445 / 成功 445 / 失败 0 / 已标记 3 并发数: 9 吞吐量: 5.84 roles/s 阶段耗时: - 分布式锁: 0.020s - 查询待处理角色: 0.120s - KVrocks状态过滤: 0.026s - 特殊服务器配置加载: 0.000s - worker处理: 75.911s - OpenIM通知: 0.165s 调用统计: - KVrocks状态写入: 3次, 累计 0.021s, 平均 0.007s, P50 0.007s, P95 0.007s, P99 0.007s, 最大 0.007s - roledetail: 445次, 累计 378.672s, 平均 0.851s, P50 0.717s, P95 1.871s, P99 2.496s, 最大 5.751s - 基础抽签队列写入: 3次, 累计 0.077s, 平均 0.026s, P50 0.027s, P95 0.027s, P99 0.027s, 最大 0.035s - 审核记录写入: 3次, 累计 0.229s, 平均 0.076s, P50 0.076s, P95 0.076s, P99 0.076s, 最大 0.077s - 服务器查询: 3次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 91次, 累计 251.922s, 平均 2.768s, P50 0.426s, P95 10.522s, P99 17.050s, 最大 18.111s 请求明细: - roledetail HTTP请求: 448 - roledetail重试: 3 - roledetail重试成功: 3 - roledetail首次成功: 442 worker负载: - worker 1: 60件, 忙碌 69.035s - worker 2: 39件, 忙碌 69.515s - worker 3: 51件, 忙碌 68.806s - worker 4: 46件, 忙碌 69.780s - worker 5: 56件, 忙碌 69.587s - worker 6: 55件, 忙碌 70.039s - worker 7: 49件, 忙碌 68.919s - worker 8: 51件, 忙碌 75.909s - worker 9: 38件, 忙碌 69.335s 最慢角色 Top 10: - eid=202610242300113-901-GQABWGNJ6YSE, worker=9, 总耗时=18.986s, roledetail=0.874s, 角色估价=18.111s - eid=202610242200113-132-NPEE6RXUNIOP, worker=2, 总耗时=17.911s, roledetail=0.861s, 角色估价=17.050s - eid=202610112200113-527-KUYOND2YNPHO, worker=3, 总耗时=15.097s, roledetail=3.182s, 角色估价=11.915s - eid=202610251200113-413-F5I6G9BOBZ6Y, worker=9, 总耗时=12.548s, roledetail=0.340s, 角色估价=12.208s - eid=202608080000113-527-HDKNGGQL6TVC, worker=4, 总耗时=11.423s, roledetail=0.459s, 角色估价=10.965s - eid=202610251200113-901-NBRYPHWBASPA, worker=7, 总耗时=11.254s, roledetail=0.732s, 角色估价=10.522s - eid=202610242000113-901-CCRBBGSTFVGU, worker=2, 总耗时=10.277s, roledetail=0.747s, 角色估价=9.530s - eid=202605240900113-730-RGDGFZPVPGYN, worker=6, 总耗时=9.931s, roledetail=0.861s, 角色估价=9.071s - eid=202607030700113-527-CJZ6MXESFZQT, worker=5, 总耗时=9.229s, roledetail=0.710s, 角色估价=8.519s - eid=202610211300113-9-8IP3VCK37UKGXM, worker=8, 总耗时=9.152s, roledetail=0.826s, 角色估价=8.326s =============================================== › |
| 2026-10-25 13:30:48.518 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 445/445 › |
| 2026-10-25 13:30:46.125 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=400/538 waiting=0 ordered=0 pushed=18 errors=0 › |
| 2026-10-25 13:30:45.169 · WARN · cbg-trade · test |
| [armor_report.go:119] omit init_damage_raw for ambiguous mixed weapon gems, eid=202610251200113-305-A5DXZMBSE4GE › |
| 2026-10-25 13:30:45.127 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610251300113-930-XCOYO2OZZOHF server_id=930 reason=value status=1 status_code=OK kind_id=35 equip_type=3745 listing_status=2 › |
| 2026-10-25 13:30:42.596 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610251300113-930-8PNZGASSAYBM server_id=930 reason=value status=1 status_code=OK kind_id=35 equip_type=3745 listing_status=2 › |
| 2026-10-25 13:30:42.094 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-10-25 13:30:40.835 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202610251300113-769-IXRLDI8UXFQU server_id=769 reason=value status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-10-25 13:30:40.508 · INFO · cbg-trade · test |
| [update.go:191] update success › |
| 2026-10-25 13:30:40.508 · INFO · cbg-trade · test |
| [update.go:176] updated 54/60 random push reviews › |