| 2026-11-04 18:39:17.943 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.90 minutes] elapsed › |
| 2026-11-04 18:39:17.942 · ERROR · cbg-trade · test |
| [openim.go:49] OpenIM send failed: server_id=1 request_id=cbg-trade-a60583c4-f918-4940-a3cf-7df7313f6da8: OpenIM transport failed; delivery unconfirmed, retain request_id › |
| 2026-11-04 18:39:09.525 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-04 18:39:07.904 · INFO · cbg-trade · test |
| [subcheck.go:401] [sub_check] completed: processed=362/362 waiting=0 ordered=0 pushed=20 errors=0 › |
| 2026-11-04 18:39:07.904 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 43.510s 物品: 查询 2096 / 待处理 362 / 已处理 362 / 成功 362 / 失败 0 并发数: 4 历史归档: 989 吞吐量: 8.32 items/s 阶段耗时: - 查询待处理物品: 0.133s - KVrocks状态过滤: 0.039s - 历史数据归档: 0.355s - 订阅基础数据加载: 0.072s - 订阅规则加载: 0.986s - 历史推送价格加载: 0.060s - worker处理: 39.794s - 邮件发送: 2.070s 调用统计: - KVrocks状态写入: 362次, 累计 6.358s, 平均 0.018s, P50 0.011s, P95 0.040s, P99 0.240s, 最大 0.269s - itemdetail: 362次, 累计 7.312s, 平均 0.020s, P50 0.014s, P95 0.038s, P99 0.129s, 最大 0.411s - 估价: 362次, 累计 137.329s, 平均 0.379s, P50 0.313s, P95 0.881s, P99 1.290s, 最大 1.365s - 推送记录写入: 20次, 累计 1.883s, 平均 0.094s, P50 0.085s, P95 0.154s, P99 0.154s, 最大 0.165s - 物品描述解析: 176次, 累计 2.845s, 平均 0.016s, P50 0.013s, P95 0.037s, P99 0.062s, 最大 0.079s - 订阅匹配与推送: 362次, 累计 7.326s, 平均 0.020s, P50 0.011s, P95 0.088s, P99 0.182s, 最大 0.443s - 订阅规则匹配: 452次, 累计 2.916s, 平均 0.006s, P50 0.000s, P95 0.024s, P99 0.047s, 最大 0.079s worker负载: - worker 1: 93件, 忙碌 39.492s - worker 2: 95件, 忙碌 39.791s - worker 3: 93件, 忙碌 39.581s - worker 4: 81件, 忙碌 39.480s 最慢物品 Top 10: - eid=202611041800113-3-WSX7MAFWCZHRRT, worker=4, 总耗时=1.510s, KVrocks状态写入=0.079s, itemdetail=0.021s, 估价=1.356s, 物品处理=1.510s, 订阅匹配与推送=0.053s - eid=202611041800113-116-UAMLVTF9HM9S, worker=1, 总耗时=1.475s, KVrocks状态写入=0.010s, itemdetail=0.007s, 估价=1.276s, 物品处理=1.475s, 物品描述解析=0.011s, 订阅匹配与推送=0.182s - eid=202611041800113-554-NWA5KRFNUFJ8, worker=2, 总耗时=1.399s, KVrocks状态写入=0.009s, itemdetail=0.009s, 估价=1.262s, 物品处理=1.399s, 订阅匹配与推送=0.119s - eid=202611041800113-367-8JO8ORRFFMLP, worker=1, 总耗时=1.385s, KVrocks状态写入=0.009s, itemdetail=0.011s, 估价=1.365s, 物品处理=1.385s, 订阅匹配与推送=0.000s - eid=202611041800113-9-84VCPTB08D0DDG, worker=3, 总耗时=1.361s, KVrocks状态写入=0.008s, itemdetail=0.009s, 估价=1.344s, 物品处理=1.361s, 订阅匹配与推送=0.000s - eid=202611041800113-159-8T90VENHB03O, worker=4, 总耗时=1.342s, KVrocks状态写入=0.006s, itemdetail=0.039s, 估价=1.290s, 物品处理=1.342s, 物品描述解析=0.007s, 订阅匹配与推送=0.007s - eid=202611041800113-841-NIV3V9IEA8JD, worker=2, 总耗时=1.333s, KVrocks状态写入=0.039s, itemdetail=0.076s, 估价=1.196s, 物品处理=1.333s, 物品描述解析=0.022s, 订阅匹配与推送=0.022s - eid=202611041800113-901-6IGAL8N1ZEA9, worker=1, 总耗时=1.321s, KVrocks状态写入=0.005s, itemdetail=0.018s, 估价=1.297s, 物品处理=1.321s, 订阅匹配与推送=0.000s - eid=202611041800113-416-US52B04L6AOV, worker=4, 总耗时=1.301s, KVrocks状态写入=0.026s, itemdetail=0.011s, 估价=0.820s, 物品处理=1.301s, 订阅匹配与推送=0.443s - eid=202611041800113-459-ZZLLEMIRREPB, worker=1, 总耗时=1.288s, KVrocks状态写入=0.008s, itemdetail=0.017s, 估价=1.252s, 物品处理=1.288s, 订阅匹配与推送=0.012s =========================================== › |
| 2026-11-04 18:39:05.833 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=362/362 waiting=0 ordered=0 pushed=20 errors=0 › |
| 2026-11-04 18:39:00.121 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/362 waiting=0 ordered=0 pushed=17 errors=0 › |
| 2026-11-04 18:38:59.248 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.53 minutes] elapsed › |
| 2026-11-04 18:38:55.287 · ERROR · cbg-trade · test |
| [kvclient.go:185] Failed to batch get kv kv batch get failed: status=400 body={"code":400,"message":"keys数量不能超过100"}, keys: 141 › |
| 2026-11-04 18:38:55.287 · ERROR · cbg-trade · test |
| [sub_flow_random_push_review.go:371] batch get sub flow item details failed, count: 141, error: kv batch get failed: status=400 body={"code":400,"message":"keys数量不能超过100"} › |
| 2026-11-04 18:38:53.122 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.48 minutes] elapsed › |
| 2026-11-04 18:38:53.113 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 28.688s 角色: 查询 130 / 待处理 129 / 已处理 129 / 成功 128 / 失败 1 / 已标记 0 并发数: 8 吞吐量: 4.50 roles/s 阶段耗时: - 分布式锁: 0.008s - 查询待处理角色: 0.059s - KVrocks状态过滤: 0.013s - 特殊服务器配置加载: 0.000s - worker处理: 28.430s - OpenIM通知: 0.178s 调用统计: - roledetail: 129次, 累计 97.014s, 平均 0.752s, P50 0.614s, P95 1.756s, P99 1.961s, 最大 2.358s - 角色估价: 30次, 累计 65.703s, 平均 2.190s, P50 1.212s, P95 7.204s, P99 8.189s, 最大 11.402s 请求明细: - roledetail HTTP请求: 132 - roledetail重试: 3 - roledetail重试成功: 3 - roledetail首次成功: 125 worker负载: - worker 1: 12件, 忙碌 17.048s - worker 2: 17件, 忙碌 28.429s - worker 3: 9件, 忙碌 20.427s - worker 4: 17件, 忙碌 18.547s - worker 5: 11件, 忙碌 20.643s - worker 6: 23件, 忙碌 17.235s - worker 7: 17件, 忙碌 23.147s - worker 8: 23件, 忙碌 17.245s 最慢角色 Top 10: - eid=202610282300113-527-IC1VYOKKLZZF, worker=2, 总耗时=11.916s, roledetail=0.514s, 角色估价=11.402s - eid=202611031800113-926-FXCKYP9LXJQN, worker=5, 总耗时=8.961s, roledetail=0.772s, 角色估价=8.189s - eid=202607282100113-352-NFNEBHGJJ9CN, worker=3, 总耗时=7.858s, roledetail=0.654s, 角色估价=7.204s - eid=202610061800113-60-MKGADKUARJ9OT, worker=7, 总耗时=6.215s, roledetail=0.395s, 角色估价=5.820s - eid=202611030100113-554-PSPC1L3VC428, worker=1, 总耗时=5.431s, roledetail=1.756s, 角色估价=3.675s - eid=202611041800113-407-REQTZTWYFKCF, worker=3, 总耗时=5.241s, roledetail=1.205s, 角色估价=4.036s - eid=202609060900113-326-0T6JO3ZQ4CDH, worker=4, 总耗时=4.606s, roledetail=0.364s, 角色估价=4.242s - eid=202610071200113-9-48EQ6HPLUXD5QQ, worker=7, 总耗时=3.327s, roledetail=0.599s, 角色估价=2.728s - eid=202611041800113-407-IABYHVVKVIPC, worker=2, 总耗时=3.293s, roledetail=1.932s, 角色估价=1.361s - eid=202611041700113-9-BLEO43WYID1WBD, worker=5, 总耗时=3.193s, roledetail=0.609s, 角色估价=2.584s 错误汇总: - roledetail: 1 - 角色处理: 1 =============================================== › |
| 2026-11-04 18:38:52.935 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 129/129 › |
| 2026-11-04 18:38:49.475 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=200/362 waiting=0 ordered=0 pushed=9 errors=0 › |
| 2026-11-04 18:38:48.946 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=31 dropped=0 › |
| 2026-11-04 18:38:45.280 · ERROR · cbg-trade · test |
| [sub_flow_random_push_review.go:371] batch get sub flow item details failed, count: 141, error: kv batch get failed: status=400 body={"code":400,"message":"keys数量不能超过100"} › |
| 2026-11-04 18:38:45.280 · ERROR · cbg-trade · test |
| [kvclient.go:185] Failed to batch get kv kv batch get failed: status=400 body={"code":400,"message":"keys数量不能超过100"}, keys: 141 › |
| 2026-11-04 18:38:44.393 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.33 minutes] elapsed › |
| 2026-11-04 18:38:38.882 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-04 18:38:38.483 · INFO · cbg-trade · test |
| [sub_random_draw_purchase.go:243] SetSubRandomDrawPurchaseResult: saved, account=dansen123888@163.com, eid=202611041700113-911-TTLXTIRQKOFW, status=1 › |