| 2026-09-04 15:28:05.409 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [1.04 minutes] elapsed › |
| 2026-09-04 15:28:05.400 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 61.919s 角色: 查询 812 / 待处理 789 / 已处理 789 / 成功 789 / 失败 0 / 已标记 8 并发数: 16 吞吐量: 12.74 roles/s 阶段耗时: - 分布式锁: 0.006s - 查询待处理角色: 0.123s - KVrocks状态过滤: 0.029s - 特殊服务器配置加载: 0.000s - worker处理: 60.955s - 飞书通知: 0.806s 调用统计: - KVrocks状态写入: 8次, 累计 0.072s, 平均 0.009s, P50 0.008s, P95 0.015s, P99 0.015s, 最大 0.017s - roledetail: 789次, 累计 542.634s, 平均 0.688s, P50 0.480s, P95 1.294s, P99 3.530s, 最大 14.807s - 基础抽签队列写入: 8次, 累计 0.141s, 平均 0.018s, P50 0.014s, P95 0.021s, P99 0.021s, 最大 0.038s - 审核记录写入: 8次, 累计 0.985s, 平均 0.123s, P50 0.124s, P95 0.128s, P99 0.128s, 最大 0.130s - 服务器查询: 8次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 126次, 累计 312.204s, 平均 2.478s, P50 0.328s, P95 10.630s, P99 16.835s, 最大 21.905s 请求明细: - roledetail HTTP请求: 798 - roledetail超时: 6 - roledetail重试: 9 - roledetail重试成功: 8 - roledetail首次成功: 781 - 代理禁用: 9 worker负载: - worker 1: 52件, 忙碌 49.109s - worker 2: 77件, 忙碌 49.438s - worker 3: 59件, 忙碌 49.031s - worker 4: 63件, 忙碌 49.481s - worker 5: 75件, 忙碌 55.715s - worker 6: 25件, 忙碌 57.536s - worker 7: 69件, 忙碌 57.105s - worker 8: 21件, 忙碌 51.032s - worker 9: 41件, 忙碌 55.787s - worker 10: 31件, 忙碌 50.950s - worker 11: 39件, 忙碌 53.667s - worker 12: 48件, 忙碌 58.114s - worker 13: 62件, 忙碌 50.286s - worker 14: 45件, 忙碌 54.587s - worker 15: 61件, 忙碌 60.952s - worker 16: 21件, 忙碌 53.250s 最慢角色 Top 10: - eid=202609041400113-378-XPEXTBEXQXSZ, worker=16, 总耗时=22.536s, KVrocks状态写入=0.005s, roledetail=0.496s, 基础抽签队列写入=0.015s, 审核记录写入=0.115s, 服务器查询=0.000s, 角色估价=21.905s - eid=202609022000113-669-VEN5DF6FZBIJ, worker=6, 总耗时=19.125s, roledetail=0.766s, 角色估价=18.359s - eid=202607260400113-9-HRTPDK7VOX20NZ, worker=9, 总耗时=17.870s, roledetail=1.035s, 角色估价=16.835s - eid=202609041400113-414-1PDIBZEJFEAH, worker=8, 总耗时=14.807s, roledetail=14.807s - eid=202605260200113-527-QFCWK5OIEMQJ, worker=15, 总耗时=14.211s, roledetail=1.314s, 角色估价=12.897s - eid=202604081500113-407-6JM3HRSRBVZD, worker=14, 总耗时=13.484s, roledetail=0.372s, 角色估价=13.112s - eid=202608241300113-416-4MJZ2Q53DYYT, worker=16, 总耗时=13.316s, roledetail=13.316s - eid=202609031700113-326-8JELEIJKGT8X, worker=6, 总耗时=12.382s, roledetail=0.361s, 角色估价=12.021s - eid=202609041400113-378-QFHSG0QIIUVL, worker=10, 总耗时=11.741s, KVrocks状态写入=0.015s, roledetail=0.586s, 基础抽签队列写入=0.021s, 审核记录写入=0.130s, 服务器查询=0.000s, 角色估价=10.990s - eid=202609041400113-207-HOXKUB76IIJW, worker=14, 总耗时=11.719s, roledetail=11.719s =============================================== › |
| 2026-09-04 15:28:04.593 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 789/789 › |
| 2026-09-04 15:28:04.552 · INFO · cbg-trade · test |
| [update.go:185] update randomPushReview: concurrency: 4 › |
| 2026-09-04 15:28:04.552 · INFO · cbg-trade · test |
| [clickhouse.go:67] ClickHouse connected successfully, database=cbg_item host=192.168.101.203 port=9000 › |
| 2026-09-04 15:28:04.552 · INFO · cbg-trade · test |
| [netstub.go:24] Starting net stub on port 9340... › |
| 2026-09-04 15:28:04.511 · INFO · cbg-trade · test |
| [database.go:689] mysql connection pool configured: MaxOpenConns=50, MaxIdleConns=10, ConnMaxLifetime=300s › |
| 2026-09-04 15:28:04.328 · INFO · cbg-trade · test |
| [database.go:651] mysql connecting to 124.220.31.60:3306/cbg as root › |
| 2026-09-04 15:28:04.302 · INFO · cbg-trade · test |
| [redis.go:41] Redis client initialized successfully › |
| 2026-09-04 15:28:04.282 · INFO · cbg-trade · test |
| [redis.go:34] Redis connecting to 192.168.101.203:6379, timeout: 30s › |
| 2026-09-04 15:28:04.282 · INFO · cbg-trade · test |
| [config.go:110] local ip [192.168.101.204 172.19.0.1 172.20.0.1 172.17.0.1 172.21.0.1 172.18.0.1] › |
| 2026-09-04 15:28:04.279 · INFO · cbg-trade · test |
| [main.go:37] Current directory: /app › |
| 2026-09-04 15:28:04.279 · INFO · cbg-trade · test |
| [main.go:30] Git Commit: revision -> [unknown] › |
| 2026-09-04 15:28:04.278 · INFO · cbg-trade · test |
| [main.go:29] Starting server, time -> [2026-09-04 15:28:04] › |
| 2026-09-04 15:28:04.007 · INFO · cbg-cookie-pool · test |
| [randomdraw_cache.go:94] refresh random draw config cache success, proxy groups: 8, proxies: 60, cookie servers: 2, accounts: 424, high level roles: 11 › |
| 2026-09-04 15:28:02.568 · INFO · cbg-trade · test |
| [report.go:167] ========== RandomDraw 汇总与性能分析报告 ========== 结果: success_with_errors 总耗时: 58.984s 停止原因: checkpoint 账号: lesmr41@163.com (ID=194), 代理ID: 30 页面: 尝试 20 / 成功 20 / 失败 0 数据: 处理 292 / 新增 163 / 重复 129 / 时间过滤 0 / 归档 183 Mailbox: 成功 59 / 失败 163 吞吐量: 4.95 items/s, 0.34 pages/s 异常: 请求 0 / 解析 0 / 状态异常 1 / 密保 0 / 无代理 0 / 致命 0 最后错误: mailbox Mailbox:RoleFlow is full (size: 100000) 阶段耗时: - 数据库表检查: 1.198s - 获取Cookie: 0.001s - 加载抓取配置: 0.180s - 分页抓取: 54.476s - 历史归档: 0.248s - 保存Checkpoint: 0.129s - 保存运行统计: 0.183s - 发送通知与更新资源统计: 2.569s 调用统计: - Mailbox写入: 222次, 累计 3.424s, 平均 0.015s, P50 0.014s, P95 0.032s, P99 0.041s, 最大 0.050s - 代理获取: 21次, 累计 0.745s, 平均 0.035s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.745s - 分页随机等待: 21次, 累计 27.981s, 平均 1.332s, P50 1.243s, P95 1.990s, P99 1.990s, 最大 1.991s - 响应JSON解析: 21次, 累计 0.033s, 平均 0.002s, P50 0.002s, P95 0.002s, P99 0.002s, 最大 0.002s - 响应读取: 21次, 累计 0.068s, 平均 0.003s, P50 0.003s, P95 0.006s, P99 0.006s, 最大 0.008s - 批量写入: 18次, 累计 1.774s, 平均 0.099s, P50 0.098s, P95 0.109s, P99 0.109s, 最大 0.110s - 批量去重查询: 20次, 累计 0.972s, 平均 0.049s, P50 0.048s, P95 0.055s, P99 0.055s, 最大 0.057s - 藏宝阁HTTP请求: 21次, 累计 11.895s, 平均 0.566s, P50 0.565s, P95 0.637s, P99 0.637s, 最大 0.642s 最慢页面 Top 10: - page=1, 总耗时=7.688s, 获取=6.783s, 处理=0.905s - page=9, 总耗时=3.375s, 获取=2.462s, 处理=0.913s - page=2, 总耗时=3.133s, 获取=2.576s, 处理=0.557s - page=14, 总耗时=3.098s, 获取=2.604s, 处理=0.494s - page=4, 总耗时=2.851s, 获取=2.281s, 处理=0.571s - page=7, 总耗时=2.806s, 获取=2.011s, 处理=0.796s - page=3, 总耗时=2.734s, 获取=2.393s, 处理=0.341s - page=6, 总耗时=2.721s, 获取=2.188s, 处理=0.533s - page=20, 总耗时=2.576s, 获取=2.471s, 处理=0.106s - page=8, 总耗时=2.576s, 获取=1.855s, 处理=0.721s ================================================== › |
| 2026-09-04 15:28:02.568 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [0.99 minutes] elapsed › |
| 2026-09-04 15:28:00.025 · INFO · cbg-item · test |
| [http_server.go:420] [PerfTick] metrics Query=10 Merge=0 Insert=0 BackgroundPoolTask=0 running=5 › |
| 2026-09-04 15:27:58.090 · INFO · cbg-cookie-pool · test |
| [cookiepool.go:150] update cookie, id: 437, server: http://124.220.32.48:5500, account: caichun835301@163.com, password: BujunyaBL81481, roleid: 0, proxy: http://yhgw23r2:yhgw23r2@218.9.21.46:5858 › |
| 2026-09-04 15:27:57.155 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/747 waiting=0 ordered=0 pushed=22 errors=0 › |