| 2026-11-11 13:34:23.345 · INFO · cbg-trade · test |
| [main.go:31] Git Commit: revision -> [unknown] › |
| 2026-11-11 13:34:23.344 · INFO · cbg-trade · test |
| [main.go:30] Starting server, time -> [2026-11-11 13:34:23] › |
| 2026-11-11 13:34:20.906 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.95 minutes] elapsed › |
| 2026-11-11 13:34:20.763 · INFO · cbg-trade · test |
| [subcheck.go:429] [sub_check] completed: processed=325/325 waiting=0 ordered=0 pushed=23 errors=0 › |
| 2026-11-11 13:34:20.763 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 56.729s 物品: 查询 1870 / 待处理 325 / 已处理 325 / 成功 325 / 失败 0 并发数: 4 历史归档: 814 吞吐量: 5.73 items/s 阶段耗时: - 查询待处理物品: 0.137s - KVrocks状态过滤: 0.041s - 历史数据归档: 0.322s - 订阅基础数据加载: 0.054s - 订阅规则加载: 0.576s - 订阅候选粗筛: 0.008s - 历史推送价格加载: 0.102s - worker处理: 53.289s - 邮件发送: 2.199s 调用统计: - KVrocks状态写入: 325次, 累计 3.280s, 平均 0.010s, P50 0.009s, P95 0.018s, P99 0.027s, 最大 0.043s - itemdetail: 325次, 累计 124.513s, 平均 0.383s, P50 0.290s, P95 0.892s, P99 1.299s, 最大 1.740s - 估价: 325次, 累计 77.527s, 平均 0.239s, P50 0.203s, P95 0.512s, P99 0.749s, 最大 0.828s - 推送记录写入: 23次, 累计 2.397s, 平均 0.104s, P50 0.093s, P95 0.104s, P99 0.118s, 最大 0.329s - 物品描述解析: 139次, 累计 2.064s, 平均 0.015s, P50 0.013s, P95 0.028s, P99 0.037s, 最大 0.058s - 订阅匹配与推送: 325次, 累计 5.848s, 平均 0.018s, P50 0.011s, P95 0.102s, P99 0.126s, 最大 0.341s - 订阅规则匹配: 397次, 累计 2.128s, 平均 0.005s, P50 0.000s, P95 0.021s, P99 0.032s, 最大 0.059s worker负载: - worker 1: 78件, 忙碌 52.564s - worker 2: 79件, 忙碌 52.427s - worker 3: 87件, 忙碌 52.913s - worker 4: 81件, 忙碌 53.287s 最慢物品 Top 10: - eid=202611071300113-3-QHRF207JKTMMKY, worker=4, 总耗时=2.128s, KVrocks状态写入=0.010s, itemdetail=1.287s, 估价=0.818s, 物品处理=2.128s, 物品描述解析=0.012s, 订阅匹配与推送=0.012s - eid=202611111300113-127-BIBW5FIO48TB, worker=2, 总耗时=2.074s, KVrocks状态写入=0.009s, itemdetail=1.740s, 估价=0.223s, 物品处理=2.074s, 物品描述解析=0.010s, 订阅匹配与推送=0.102s - eid=202611111300113-199-MJYFOMHO6GKD, worker=1, 总耗时=1.800s, KVrocks状态写入=0.004s, itemdetail=1.333s, 估价=0.462s, 物品处理=1.800s, 订阅匹配与推送=0.000s - eid=202611110600113-55-XCUANSX1JMHQT, worker=3, 总耗时=1.750s, KVrocks状态写入=0.018s, itemdetail=1.379s, 估价=0.352s, 物品处理=1.750s, 订阅匹配与推送=0.000s - eid=202611100200113-554-MO59FU7BLWJE, worker=2, 总耗时=1.588s, KVrocks状态写入=0.006s, itemdetail=1.299s, 估价=0.270s, 物品处理=1.588s, 订阅匹配与推送=0.014s - eid=202611111300113-750-QOYCWZ0XLHBG, worker=3, 总耗时=1.448s, KVrocks状态写入=0.016s, itemdetail=1.309s, 估价=0.124s, 物品处理=1.448s, 订阅匹配与推送=0.000s - eid=202611111300113-344-CZ9OY828DEQI, worker=2, 总耗时=1.423s, KVrocks状态写入=0.013s, itemdetail=1.253s, 估价=0.157s, 物品处理=1.423s, 订阅匹配与推送=0.000s - eid=202611111300113-892-MH0QQHVPLU2R, worker=1, 总耗时=1.372s, KVrocks状态写入=0.006s, itemdetail=1.048s, 估价=0.297s, 物品处理=1.372s, 物品描述解析=0.022s, 订阅匹配与推送=0.022s - eid=202611111300113-920-GGVMIVLC91KX, worker=4, 总耗时=1.355s, KVrocks状态写入=0.012s, itemdetail=1.207s, 估价=0.136s, 物品处理=1.355s, 订阅匹配与推送=0.000s - eid=202611111300113-584-1CTBROAFYOZ0, worker=1, 总耗时=1.278s, KVrocks状态写入=0.018s, itemdetail=0.936s, 估价=0.193s, 物品处理=1.278s, 物品描述解析=0.027s, 订阅匹配与推送=0.131s =========================================== › |
| 2026-11-11 13:34:18.563 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=325/325 waiting=0 ordered=0 pushed=23 errors=0 › |
| 2026-11-11 13:34:17.653 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 125 items › |
| 2026-11-11 13:34:17.624 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 125 items › |
| 2026-11-11 13:34:15.532 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.33 minutes] elapsed › |
| 2026-11-11 13:34:15.516 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 19.434s 角色: 查询 201 / 待处理 195 / 已处理 195 / 成功 195 / 失败 0 / 已标记 0 并发数: 8 吞吐量: 10.03 roles/s 阶段耗时: - 分布式锁: 0.004s - 查询待处理角色: 0.056s - KVrocks状态过滤: 0.022s - 特殊服务器配置加载: 0.000s - worker处理: 19.184s - OpenIM通知: 0.168s 调用统计: - roledetail: 195次, 累计 133.237s, 平均 0.683s, P50 0.606s, P95 1.225s, P99 1.463s, 最大 1.608s - 角色估价: 38次, 累计 13.385s, 平均 0.352s, P50 0.055s, P95 1.321s, P99 1.483s, 最大 4.769s 请求明细: - roledetail HTTP请求: 195 - roledetail首次成功: 195 worker负载: - worker 1: 24件, 忙碌 18.118s - worker 2: 24件, 忙碌 17.753s - worker 3: 26件, 忙碌 17.821s - worker 4: 26件, 忙碌 18.326s - worker 5: 19件, 忙碌 19.183s - worker 6: 23件, 忙碌 18.314s - worker 7: 27件, 忙碌 18.760s - worker 8: 26件, 忙碌 18.349s 最慢角色 Top 10: - eid=202610261400113-326-H7WH4POKTSDM, worker=5, 总耗时=5.247s, roledetail=0.479s, 角色估价=4.769s - eid=202610010200113-901-7CWUJZJBFIXZ, worker=8, 总耗时=2.321s, roledetail=1.020s, 角色估价=1.301s - eid=202611010700113-326-ID9S0WUOXUDS, worker=6, 总耗时=1.986s, roledetail=0.664s, 角色估价=1.321s - eid=202610071200113-9-48EQ6HPLUXD5QQ, worker=3, 总耗时=1.820s, roledetail=0.337s, 角色估价=1.483s - eid=202611081800113-926-G1DI8A9F4EZL, worker=6, 总耗时=1.779s, roledetail=1.554s, 角色估价=0.225s - eid=202607112300113-203-GQ96WRASDWYC, worker=7, 总耗时=1.608s, roledetail=1.608s - eid=202604061100113-527-X4BOUEVRSFAY, worker=1, 总耗时=1.552s, roledetail=1.432s, 角色估价=0.120s - eid=202611111200113-249-BB7KY1DICFSP, worker=2, 总耗时=1.463s, roledetail=1.463s - eid=202609152000113-104-NIEKTQVY7GHG, worker=5, 总耗时=1.457s, roledetail=1.457s - eid=202610252100113-930-CYTDUH6HYMVX, worker=4, 总耗时=1.346s, roledetail=1.346s =============================================== › |
| 2026-11-11 13:34:15.348 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 195/195 › |
| 2026-11-11 13:34:14.983 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/325 waiting=0 ordered=0 pushed=18 errors=0 › |
| 2026-11-11 13:34:14.628 · INFO · cbg-trade · test |
| [perform_effect.go:40] Initialized perform effect cache with 38 items › |
| 2026-11-11 13:34:12.840 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 125 items › |
| 2026-11-11 13:34:12.816 · INFO · cbg-trade · test |
| [user_perform_effect_price.go:38] Initialized user perform effect price cache with 125 items › |
| 2026-11-11 13:34:12.120 · INFO · cbg-trade · test |
| [sub_random_draw_purchase.go:249] SetSubRandomDrawPurchaseResult: saved, account=liuqiu123001@163.com, eid=202611111300113-40-UNW7P3PZ6P83E, status=1 › |
| 2026-11-11 13:34:10.328 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202509091100113-705-GLKWLI1RKYG2 server_id=705 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=51 equip_type=999 listing_status=2 › |
| 2026-11-11 13:34:09.190 · INFO · cbg-trade · test |
| [clothes.go:50] Initialized clothes cache with 5642 items › |
| 2026-11-11 13:34:08.508 · INFO · cbg-trade · test |
| [eidtype.go:103] [eid_type] upstream lookup succeeded, eid=202611111300113-132-K02HFJNPJT3W server_id=132 reason=value@cbg-admin-server:value-mailbox status=1 status_code=OK kind_id=31 equip_type=3741 listing_status=2 › |
| 2026-11-11 13:34:06.600 · INFO · cbg-trade · test |
| [sub_random_draw_purchase.go:249] SetSubRandomDrawPurchaseResult: saved, account=xiatian123001@163.com, eid=202611111300113-40-UNW7P3PZ6P83E, status=1 › |