| 2026-11-08 20:44:52.388 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 388.467s 物品: 查询 1123 / 待处理 591 / 已处理 591 / 成功 586 / 失败 5 并发数: 5 历史归档: 403 吞吐量: 1.52 items/s 阶段耗时: - 查询待处理物品: 0.234s - KVrocks状态过滤: 0.024s - 历史数据归档: 0.233s - 订阅基础数据加载: 0.074s - 订阅规则加载: 1.902s - 历史推送价格加载: 0.133s - worker处理: 383.504s - 邮件发送: 2.362s 调用统计: - KVrocks状态写入: 586次, 累计 6.111s, 平均 0.010s, P50 0.007s, P95 0.023s, P99 0.053s, 最大 0.231s - itemdetail: 591次, 累计 1739.866s, 平均 2.944s, P50 1.764s, P95 9.431s, P99 26.773s, 最大 30.026s - 估价: 586次, 累计 140.176s, 平均 0.239s, P50 0.202s, P95 0.479s, P99 0.735s, 最大 1.051s - 推送记录写入: 39次, 累计 4.229s, 平均 0.108s, P50 0.096s, P95 0.151s, P99 0.203s, 最大 0.222s - 物品描述解析: 280次, 累计 3.825s, 平均 0.014s, P50 0.009s, P95 0.033s, P99 0.079s, 最大 0.213s - 订阅匹配与推送: 586次, 累计 10.288s, 平均 0.018s, P50 0.008s, P95 0.100s, P99 0.196s, 最大 0.445s - 订阅规则匹配: 742次, 累计 3.983s, 平均 0.005s, P50 0.000s, P95 0.022s, P99 0.040s, 最大 0.213s worker负载: - worker 1: 117件, 忙碌 382.553s - worker 2: 119件, 忙碌 373.855s - worker 3: 120件, 忙碌 377.816s - worker 4: 114件, 忙碌 383.500s - worker 5: 121件, 忙碌 378.748s 最慢物品 Top 10: - eid=202611081900113-750-KRG5JI5A7DDD, worker=2, 总耗时=30.026s, itemdetail=30.026s, 物品处理=30.026s - eid=202611082000113-902-G1A4X9LR7MX1, worker=1, 总耗时=30.014s, itemdetail=30.014s, 物品处理=30.014s - eid=202611082000113-730-DGNQP5QJK9MM, worker=5, 总耗时=30.005s, itemdetail=30.005s, 物品处理=30.005s - eid=202611082000113-926-WMQRXLWDMKTN, worker=1, 总耗时=30.005s, itemdetail=30.005s, 物品处理=30.005s - eid=202611082000113-414-55YEROGGSAHA, worker=4, 总耗时=30.004s, itemdetail=30.004s, 物品处理=30.004s - eid=202611082000113-15-JLTD0MDP4KWIX, worker=5, 总耗时=28.489s, KVrocks状态写入=0.009s, itemdetail=28.176s, 估价=0.303s, 物品处理=28.489s, 订阅匹配与推送=0.000s - eid=202611082000113-558-2ZB2K8YTW9RR, worker=2, 总耗时=27.045s, KVrocks状态写入=0.006s, itemdetail=26.773s, 估价=0.256s, 物品处理=27.045s, 订阅匹配与推送=0.010s - eid=202611082000113-527-VAF2QKJIASYB, worker=2, 总耗时=25.033s, KVrocks状态写入=0.007s, itemdetail=24.781s, 估价=0.222s, 物品处理=25.033s, 物品描述解析=0.022s, 订阅匹配与推送=0.023s - eid=202611081900113-911-WYPEBMTU27KO, worker=3, 总耗时=21.683s, KVrocks状态写入=0.005s, itemdetail=21.127s, 估价=0.354s, 物品处理=21.683s, 物品描述解析=0.094s, 订阅匹配与推送=0.197s - eid=202611082000113-443-SGTG09EDPMLJ, worker=4, 总耗时=20.746s, KVrocks状态写入=0.009s, itemdetail=20.544s, 估价=0.193s, 物品处理=20.746s, 订阅匹配与推送=0.000s 错误汇总: - itemdetail: 5 - 物品处理: 5 =========================================== › |
| 2026-11-08 20:44:52.388 · INFO · cbg-trade · test |
| [subcheck.go:401] [sub_check] completed: processed=591/591 waiting=0 ordered=0 pushed=39 errors=5 › |
| 2026-11-08 20:44:52.086 · INFO · cbg-trade · test |
| [update.go:141] [24/29] worker 3 check count 2, eid: 202611011900113-851-UTZ4OXUZDM4X, status 2 › |
| 2026-11-08 20:44:51.986 · INFO · cbg-trade · test |
| [update.go:141] [23/29] worker 1 check count 2, eid: 202611011900113-584-ZSMSFC9HW9ED, status 2 › |
| 2026-11-08 20:44:51.232 · INFO · cbg-trade · test |
| [update.go:141] [20/29] worker 3 check count 2, eid: 202611011900113-926-Q5P4ZBE63GJT, status 2 › |
| 2026-11-08 20:44:50.611 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [1.45 minutes] elapsed › |
| 2026-11-08 20:44:50.604 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 86.540s 角色: 查询 77 / 待处理 77 / 已处理 77 / 成功 74 / 失败 3 / 已标记 0 并发数: 8 吞吐量: 0.89 roles/s 阶段耗时: - 分布式锁: 0.004s - 查询待处理角色: 0.038s - KVrocks状态过滤: 0.010s - 特殊服务器配置加载: 0.000s - worker处理: 86.333s - OpenIM通知: 0.156s 调用统计: - roledetail: 77次, 累计 559.801s, 平均 7.270s, P50 3.759s, P95 22.636s, P99 30.000s, 最大 30.000s - 角色估价: 14次, 累计 34.278s, 平均 2.448s, P50 2.457s, P95 4.909s, P99 4.909s, 最大 5.635s 请求明细: - roledetail HTTP请求: 74 - roledetail超时: 2 - roledetail首次成功: 74 worker负载: - worker 1: 13件, 忙碌 64.223s - worker 2: 7件, 忙碌 72.917s - worker 3: 9件, 忙碌 71.827s - worker 4: 13件, 忙碌 85.599s - worker 5: 5件, 忙碌 72.514s - worker 6: 6件, 忙碌 65.772s - worker 7: 13件, 忙碌 74.895s - worker 8: 11件, 忙碌 86.333s 最慢角色 Top 10: - eid=202611082000113-285-FCHTULHIXNEX, worker=2, 总耗时=30.000s, roledetail=30.000s - eid=202611010000113-1026-HSC22MZLCUN, worker=8, 总耗时=30.000s, roledetail=30.000s - eid=202610221600113-967-H3KHBIWKOQYU, worker=7, 总耗时=26.373s, roledetail=26.373s - eid=202610291500113-926-AMG9J9V3OSRV, worker=5, 总耗时=26.276s, roledetail=20.641s, 角色估价=5.635s - eid=202611082000113-84-AQ3NCGMIJAPUR, worker=3, 总耗时=25.633s, roledetail=25.633s - eid=202610171800113-527-4FYTOMJTC0JY, worker=4, 总耗时=22.960s, roledetail=20.438s, 角色估价=2.522s - eid=202611082000113-878-BDQCD8VMUJHV, worker=5, 总耗时=22.636s, roledetail=22.636s - eid=202611082000113-84-JGIPMECVBWWIL, worker=7, 总耗时=22.013s, roledetail=22.013s - eid=202609270700113-443-6ECJGW6UNYZ3, worker=5, 总耗时=21.474s, roledetail=21.474s - eid=202610300700113-1033-L0SDGXBNCA1, worker=6, 总耗时=20.939s, roledetail=20.939s 错误汇总: - roledetail: 3 - 角色处理: 3 =============================================== › |
| 2026-11-08 20:44:50.448 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 77/77 › |
| 2026-11-08 20:44:50.448 · ERROR · cbg-trade · test |
| [single_line.go:43] new role check failed, eid=202611010000113-1026-HSC22MZLCUN: detail service: TIMEOUT (HTTP 504) › |
| 2026-11-08 20:44:50.323 · INFO · cbg-trade · test |
| [update.go:143] [13/29] worker 1 check count 0, eid: 202611081900113-407-DB0T1NUTN3SR, status 3->4 › |
| 2026-11-08 20:44:50.025 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=591/591 waiting=0 ordered=0 pushed=39 errors=5 › |
| 2026-11-08 20:44:49.276 · INFO · cbg-trade · test |
| [update.go:141] [11/29] worker 2 check count 0, eid: 202611081900113-407-KNPFKIJ6KULY, status 2 › |
| 2026-11-08 20:44:48.110 · INFO · cbg-trade · test |
| [update.go:141] [17/29] worker 4 check count 1, eid: 202611081900113-9-DWFHNIB8EC66UG, status 2 › |
| 2026-11-08 20:44:47.413 · ERROR · cbg-trade · test |
| [update.go:134] [19/29] worker 3 failed to get item detail, eid: 202611052300113-207-PIP74ZBIKWCV, server_id: 207, err: detail service: UPSTREAM_ERROR (HTTP 502) › |
| 2026-11-08 20:44:47.060 · ERROR · cbg-trade · test |
| [role_value.go:246] valuation settlement failed, eid=202611082000113-146-DS5J9EOGBGCM user_id=352: context canceled › |
| 2026-11-08 20:44:47.012 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611082000113-1019-IKVL5OPWPEI server_id=1019 reason=value status=1 status_code=OK kind_id=49 equip_type=997 listing_status=2 › |
| 2026-11-08 20:44:46.912 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611082000113-146-DS5J9EOGBGCM server_id=146 reason=value status=1 status_code=OK kind_id=77 equip_type=50021 listing_status=2 › |
| 2026-11-08 20:44:46.837 · ERROR · cbg-trade · test |
| [update.go:134] [18/29] worker 3 failed to get item detail, eid: 202611060000113-851-ZPID2Q2341FE, server_id: 851, err: detail service: UPSTREAM_ERROR (HTTP 502) › |
| 2026-11-08 20:44:45.864 · INFO · cbg-trade · test |
| [update.go:141] [16/29] worker 3 check count 0, eid: 202611080000113-132-S0WSDJBLMVQ8, status 2 › |
| 2026-11-08 20:44:45.727 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |