| 2026-11-08 02:04:23.321 · INFO · cbg-trade · test |
| [main.go:31] Git Commit: revision -> [unknown] › |
| 2026-11-08 02:04:23.321 · INFO · cbg-trade · test |
| [main.go:38] Current directory: /app › |
| 2026-11-08 02:04:23.320 · INFO · cbg-trade · test |
| [main.go:30] Starting server, time -> [2026-11-08 02:04:23] › |
| 2026-11-08 02:03:57.007 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=1422 dropped=3 › |
| 2026-11-08 02:03:56.664 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.54 minutes] elapsed › |
| 2026-11-08 02:03:56.527 · INFO · cbg-trade · test |
| [subcheck.go:401] [sub_check] completed: processed=257/257 waiting=0 ordered=0 pushed=18 errors=0 › |
| 2026-11-08 02:03:56.526 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 32.273s 物品: 查询 1624 / 待处理 257 / 已处理 257 / 成功 257 / 失败 0 并发数: 4 历史归档: 785 吞吐量: 7.96 items/s 阶段耗时: - 查询待处理物品: 0.127s - KVrocks状态过滤: 0.028s - 历史数据归档: 0.310s - 订阅基础数据加载: 0.065s - 订阅规则加载: 1.148s - 历史推送价格加载: 0.061s - worker处理: 28.839s - 邮件发送: 1.695s 调用统计: - KVrocks状态写入: 257次, 累计 2.459s, 平均 0.010s, P50 0.008s, P95 0.021s, P99 0.032s, 最大 0.045s - itemdetail: 257次, 累计 7.921s, 平均 0.031s, P50 0.012s, P95 0.035s, P99 0.322s, 最大 1.126s - 估价: 257次, 累计 100.189s, 平均 0.390s, P50 0.275s, P95 0.924s, P99 1.663s, 最大 7.671s - 推送记录写入: 18次, 累计 1.953s, 平均 0.109s, P50 0.087s, P95 0.213s, P99 0.213s, 最大 0.322s - 物品描述解析: 121次, 累计 1.593s, 平均 0.013s, P50 0.010s, P95 0.025s, P99 0.028s, 最大 0.222s - 订阅匹配与推送: 257次, 累计 4.134s, 平均 0.016s, P50 0.008s, P95 0.094s, P99 0.205s, 最大 0.338s - 订阅规则匹配: 353次, 累计 1.658s, 平均 0.005s, P50 0.000s, P95 0.016s, P99 0.026s, 最大 0.223s worker负载: - worker 1: 59件, 忙碌 28.683s - worker 2: 57件, 忙碌 28.549s - worker 3: 76件, 忙碌 28.837s - worker 4: 65件, 忙碌 28.648s 最慢物品 Top 10: - eid=202611080100113-1030-HYQBEPSGBDZ, worker=1, 总耗时=7.690s, KVrocks状态写入=0.008s, itemdetail=0.010s, 估价=7.671s, 物品处理=7.690s, 订阅匹配与推送=0.000s - eid=202611080100113-584-CPQ1L8WBMS0Z, worker=2, 总耗时=1.832s, KVrocks状态写入=0.008s, itemdetail=0.017s, 估价=1.807s, 物品处理=1.832s, 订阅匹配与推送=0.000s - eid=202611080100113-976-VZCFR1ECCECP, worker=3, 总耗时=1.790s, KVrocks状态写入=0.005s, itemdetail=0.024s, 估价=1.663s, 物品处理=1.790s, 物品描述解析=0.010s, 订阅匹配与推送=0.098s - eid=202611080100113-558-UJOWFJCU6K0X, worker=4, 总耗时=1.712s, KVrocks状态写入=0.008s, itemdetail=0.019s, 估价=1.674s, 物品处理=1.712s, 物品描述解析=0.011s, 订阅匹配与推送=0.012s - eid=202611080100113-459-SN1ZVZBY2P1P, worker=4, 总耗时=1.549s, KVrocks状态写入=0.029s, itemdetail=0.032s, 估价=1.469s, 物品处理=1.549s, 物品描述解析=0.019s, 订阅匹配与推送=0.019s - eid=202611080100113-197-5ZE7N00DA5IS, worker=2, 总耗时=1.491s, KVrocks状态写入=0.006s, itemdetail=0.010s, 估价=1.292s, 物品处理=1.491s, 物品描述解析=0.012s, 订阅匹配与推送=0.183s - eid=202611080100113-1023-W8JXWSDCTOJ, worker=2, 总耗时=1.429s, KVrocks状态写入=0.009s, itemdetail=0.010s, 估价=1.402s, 物品处理=1.429s, 订阅匹配与推送=0.008s - eid=202611050200113-39-OTLPXOGCKAL5Y, worker=2, 总耗时=1.401s, KVrocks状态写入=0.014s, itemdetail=1.126s, 估价=0.237s, 物品处理=1.401s, 物品描述解析=0.023s, 订阅匹配与推送=0.024s - eid=202611080100113-1039-25GLN8JTGG9, worker=2, 总耗时=1.345s, KVrocks状态写入=0.006s, itemdetail=0.013s, 估价=1.326s, 物品处理=1.345s, 订阅匹配与推送=0.000s - eid=202611080100113-625-GPOHAQBGN2DC, worker=2, 总耗时=1.333s, KVrocks状态写入=0.016s, itemdetail=0.008s, 估价=1.283s, 物品处理=1.333s, 物品描述解析=0.025s, 订阅匹配与推送=0.026s =========================================== › |
| 2026-11-08 02:03:54.830 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=257/257 waiting=0 ordered=0 pushed=18 errors=0 › |
| 2026-11-08 02:03:51.853 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-11-08 02:03:50.138 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=200/257 waiting=0 ordered=0 pushed=16 errors=0 › |
| 2026-11-08 02:03:47.111 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.38 minutes] elapsed › |
| 2026-11-08 02:03:47.093 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 22.729s 角色: 查询 173 / 待处理 173 / 已处理 173 / 成功 173 / 失败 0 / 已标记 1 并发数: 8 吞吐量: 7.61 roles/s 阶段耗时: - 分布式锁: 0.004s - 查询待处理角色: 0.050s - KVrocks状态过滤: 0.018s - 特殊服务器配置加载: 0.000s - worker处理: 22.012s - OpenIM通知: 0.645s 调用统计: - KVrocks状态写入: 1次, 累计 0.019s, 平均 0.019s, P50 0.019s, P95 0.019s, P99 0.019s, 最大 0.019s - roledetail: 173次, 累计 95.447s, 平均 0.552s, P50 0.476s, P95 1.128s, P99 1.280s, 最大 1.501s - 基础抽签队列写入: 1次, 累计 0.022s, 平均 0.022s, P50 0.022s, P95 0.022s, P99 0.022s, 最大 0.022s - 审核记录写入: 1次, 累计 0.072s, 平均 0.072s, P50 0.072s, P95 0.072s, P99 0.072s, 最大 0.072s - 服务器查询: 1次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 57次, 累计 61.883s, 平均 1.086s, P50 0.024s, P95 4.930s, P99 5.467s, 最大 7.156s 请求明细: - roledetail HTTP请求: 173 - roledetail首次成功: 173 worker负载: - worker 1: 20件, 忙碌 20.272s - worker 2: 14件, 忙碌 18.624s - worker 3: 20件, 忙碌 18.892s - worker 4: 18件, 忙碌 18.811s - worker 5: 34件, 忙碌 18.781s - worker 6: 34件, 忙碌 18.734s - worker 7: 20件, 忙碌 22.011s - worker 8: 13件, 忙碌 21.322s 最慢角色 Top 10: - eid=202611080100113-657-M52QFZNXZIBT, worker=2, 总耗时=8.606s, KVrocks状态写入=0.019s, roledetail=1.337s, 基础抽签队列写入=0.022s, 审核记录写入=0.072s, 服务器查询=0.000s, 角色估价=7.156s - eid=202611080100113-554-UKKUVSE0MH6T, worker=3, 总耗时=6.668s, roledetail=1.201s, 角色估价=5.467s - eid=202609102000113-926-I5ZM9WQV7M7V, worker=8, 总耗时=5.446s, roledetail=0.515s, 角色估价=4.930s - eid=202611080100113-669-EZCVBOPOQVSN, worker=8, 总耗时=5.410s, roledetail=0.392s, 角色估价=5.018s - eid=202610291000113-554-S0I5DKUSHSW1, worker=1, 总耗时=4.613s, roledetail=0.989s, 角色估价=3.623s - eid=202610271600113-584-MDKATZCE2N5B, worker=7, 总耗时=4.490s, roledetail=1.501s, 角色估价=2.989s - eid=202611080100113-554-FKA6HALIHZJY, worker=4, 总耗时=4.346s, roledetail=0.440s, 角色估价=3.906s - eid=202607010000113-901-PNMUVGYKU9V5, worker=7, 总耗时=4.165s, roledetail=0.763s, 角色估价=3.403s - eid=202611080100113-554-KFJPW6MGPQFS, worker=1, 总耗时=4.118s, roledetail=0.789s, 角色估价=3.329s - eid=202610141700113-352-XHTHXR7A2GVF, worker=4, 总耗时=3.781s, roledetail=0.620s, 角色估价=3.162s =============================================== › |
| 2026-11-08 02:03:46.448 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 173/173 › |
| 2026-11-08 02:03:39.977 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=100/257 waiting=0 ordered=0 pushed=7 errors=0 › |
| 2026-11-08 02:03:36.724 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 100/173 › |
| 2026-11-08 02:03:30.382 · INFO · cbg-trade · test |
| [update.go:180] updated 33/36 random push reviews › |
| 2026-11-08 02:03:30.382 · INFO · cbg-trade · test |
| [main.go:63] Server exit, [0.11 minutes] elapsed › |
| 2026-11-08 02:03:30.382 · INFO · cbg-trade · test |
| [update.go:195] update success › |
| 2026-11-08 02:03:30.305 · INFO · cbg-trade · test |
| [update.go:143] [34/36] worker 4 check count 2, eid: 202611010100113-127-3AEOEI9F5G0B, status 3->6 › |
| 2026-11-08 02:03:30.253 · INFO · cbg-trade · test |
| [update.go:141] [35/36] worker 1 check count 2, eid: 202611010100113-229-FF0HA4QEF7ZK, status 2 › |