| 2026-10-11 23:24:02.796 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: XSEZ-KURS-7613-6979 › |
| 2026-10-11 23:24:02.282 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: XSEZ-KURS-7613-6979 › |
| 2026-10-11 23:24:01.951 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=12948 dropped=60 › |
| 2026-10-11 23:24:01.752 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: XSEZ-KURS-7613-6979 › |
| 2026-10-11 23:24:00.791 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: XSEZ-KURS-7613-6979 › |
| 2026-10-11 23:23:49.958 · INFO · cbg-trade · test |
| [random_push_review.go:194] role get random push review, token: DTHF-NURN-3826-3772 › |
| 2026-10-11 23:23:45.326 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [2.70 minutes] elapsed › |
| 2026-10-11 23:23:44.542 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [1.67 minutes] elapsed › |
| 2026-10-11 23:23:43.404 · INFO · cbg-trade · test |
| [subcheck.go:376] [sub_check] completed: processed=982/982 waiting=0 ordered=0 pushed=28 errors=439 › |
| 2026-10-11 23:23:43.403 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 99.066s 物品: 查询 3070 / 待处理 982 / 已处理 982 / 成功 543 / 失败 439 并发数: 9 历史归档: 1359 吞吐量: 9.91 items/s 阶段耗时: - 查询待处理物品: 0.161s - KVrocks状态过滤: 0.185s - 历史数据归档: 0.460s - 订阅基础数据加载: 0.052s - 订阅规则加载: 0.513s - 历史推送价格加载: 0.147s - worker处理: 95.207s - 邮件发送: 2.341s 调用统计: - KVrocks状态写入: 543次, 累计 6.123s, 平均 0.011s, P50 0.009s, P95 0.024s, P99 0.046s, 最大 0.252s - itemdetail: 982次, 累计 238.188s, 平均 0.243s, P50 0.030s, P95 0.613s, P99 0.860s, 最大 8.859s - 估价: 543次, 累计 601.151s, 平均 1.107s, P50 0.616s, P95 4.290s, P99 6.553s, 最大 10.956s - 推送记录写入: 28次, 累计 2.038s, 平均 0.073s, P50 0.069s, P95 0.074s, P99 0.074s, 最大 0.170s - 物品描述解析: 216次, 累计 3.134s, 平均 0.015s, P50 0.012s, P95 0.030s, P99 0.041s, 最大 0.072s - 订阅匹配与推送: 543次, 累计 9.399s, 平均 0.017s, P50 0.011s, P95 0.075s, P99 0.121s, 最大 0.237s - 订阅规则匹配: 602次, 累计 3.248s, 平均 0.005s, P50 0.000s, P95 0.023s, P99 0.034s, 最大 0.072s worker负载: - worker 1: 120件, 忙碌 94.959s - worker 2: 104件, 忙碌 95.204s - worker 3: 107件, 忙碌 95.101s - worker 4: 123件, 忙碌 95.031s - worker 5: 111件, 忙碌 94.805s - worker 6: 96件, 忙碌 95.007s - worker 7: 111件, 忙碌 95.010s - worker 8: 112件, 忙碌 94.959s - worker 9: 98件, 忙碌 94.812s 最慢物品 Top 10: - eid=202610112200113-527-XYWRTTSJ2GE3, worker=1, 总耗时=11.037s, KVrocks状态写入=0.032s, itemdetail=0.020s, 估价=10.956s, 物品处理=11.037s, 订阅匹配与推送=0.028s - eid=202610112200113-40-8XOBMZAFOTGRW, worker=8, 总耗时=8.859s, itemdetail=8.859s, 物品处理=8.859s - eid=202610112200113-199-WIQUW3MVVYOP, worker=9, 总耗时=7.333s, KVrocks状态写入=0.010s, itemdetail=0.037s, 估价=7.270s, 物品处理=7.333s, 订阅匹配与推送=0.017s - eid=202610112200113-34-7DVGLPDUVOOIU, worker=6, 总耗时=7.129s, KVrocks状态写入=0.008s, itemdetail=0.021s, 估价=7.086s, 物品处理=7.129s, 订阅匹配与推送=0.014s - eid=202610112200113-1036-OBPEYUOBPGE, worker=4, 总耗时=7.015s, KVrocks状态写入=0.007s, itemdetail=0.025s, 估价=6.978s, 物品处理=7.015s, 订阅匹配与推送=0.005s - eid=202610112200113-60-PTBSM3CBUOL8O, worker=4, 总耗时=6.919s, KVrocks状态写入=0.006s, itemdetail=0.020s, 估价=6.892s, 物品处理=6.919s, 订阅匹配与推送=0.000s - eid=202610112200113-77-DA1MOOEGFOWME, worker=7, 总耗时=6.821s, itemdetail=6.821s, 物品处理=6.821s - eid=202610112200113-901-R37Z9TWI9XO0, worker=7, 总耗时=6.654s, KVrocks状态写入=0.009s, itemdetail=0.011s, 估价=6.628s, 物品处理=6.654s, 订阅匹配与推送=0.007s - eid=202610112200113-12-R17ZN53LMBTN2, worker=7, 总耗时=6.619s, KVrocks状态写入=0.025s, itemdetail=0.024s, 估价=6.553s, 物品处理=6.619s, 订阅匹配与推送=0.017s - eid=202610112200113-60-HKHHTRORVLCBY, worker=6, 总耗时=6.424s, KVrocks状态写入=0.005s, itemdetail=0.014s, 估价=6.398s, 物品处理=6.424s, 订阅匹配与推送=0.007s 错误汇总: - itemdetail: 439 - 物品处理: 439 =========================================== › |
| 2026-10-11 23:23:41.061 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=982/982 waiting=0 ordered=0 pushed=28 errors=439 › |
| 2026-10-11 23:23:37.264 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=900/982 waiting=0 ordered=0 pushed=24 errors=378 › |
| 2026-10-11 23:23:34.046 · ERROR · cbg-trade · test |
| [role_value.go:230] valuation settlement failed, eid=202610062300113-554-SHSZMAZIABOH user_id=0: context canceled › |
| 2026-10-11 23:23:32.239 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=800/982 waiting=0 ordered=0 pushed=23 errors=330 › |
| 2026-10-11 23:23:31.952 · INFO · cbg-trade · test |
| [producer.go:173] [value-stats] producer buffer=0 sent=12944 dropped=60 › |
| 2026-10-11 23:23:31.561 · ERROR · cbg-trade · test |
| [dataset.go:92] pet skill not found: 56136, 202610062300113-554-SHSZMAZIABOH, stack: goroutine 986143 [running]: runtime/debug.Stack() /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/runtime/debug/stack.go:26 +0x5e cbg-trade/internal/xlsx.(*dataSet).GetPetSkill(0x10afb20?, {0xc00bb39620, 0x20}, 0xdb48) /root/sources/cbg-value/internal/xlsx/dataset.go:92 +0x9e cbg-trade/internal/report.(*PetSkill).convertShortSkillNames(0xc001c172b0?, {0xc00bb39620, 0x20}) /root/sources/cbg-value/internal/report/pet_method.go:71 +0x192 cbg-trade/internal/report.(*RoleReport).getPetData(0xc001c172b0, 0xc009126008, 0x20?) /root/sources/cbg-value/internal/report/price.go:557 +0x1a6 cbg-trade/internal/report.(*RoleReport).CreateRoleReportItem(0xc001c172b0, 0xc009126008, 0xc00662b808) /root/sources/cbg-value/internal/report/role_report.go:715 +0x405 cbg-trade/internal/report.(*RoleReport).getFromDetail(0xc001c172b0, 0xc009126008, 0x1) /root/sources/cbg-value/internal/report/role_report.go:303 +0x229 cbg-trade/internal/report.(*RoleReport).GetFromDetail(...) /root/sources/cbg-value/internal/report/role_report.go:272 cbg-trade/internal/apps/value/valueall.(*valueAll).getValue(0x203f980, {0xc009490021, 0x20}, 0xc009126008, 0xc008f49880, 0x0, 0x0, {0x12943db, 0x5}) /root/sources/cbg-value/internal/apps/value/valueall/api.go:94 +0x625 cbg-trade/internal/apps/value/valueall.(*valueAll).GetValueWithDetail(...) /root/sources/cbg-value/internal/apps/value/valueall/api.go:24 cbg-trade/internal/apps/value.(*HttpServer).GetRoleValuation(0xc000e12500, 0xc00146cf00) /root/sources/cbg-value/internal/apps/value/role_value.go:211 +0x16e5 github.com/gin-gonic/gin.(*Context).Next(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 +0x2b cbg-trade/internal/apps/value.NewHttpServer.Cors.func5(0xc00146cf00) /root/sources/cbg-value/internal/utils/cors.go:21 +0xd8 github.com/gin-gonic/gin.(*Context).Next(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 +0x2b cbg-trade/internal/apps/value.NewHttpServer.valuationStatsMiddleware.func4(0xc00146cf00) /root/sources/cbg-value/internal/apps/value/valuation_stats.go:55 +0x24e github.com/gin-gonic/gin.(*Context).Next(...) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 github.com/gin-gonic/gin.CustomRecoveryWithWriter.func1(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/recovery.go:102 +0x6f github.com/gin-gonic/gin.(*Context).Next(...) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 github.com/gin-gonic/gin.(*Engine).handleHTTPRequest(0xc0001a69c0, 0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/gin.go:620 +0x64e github.com/gin-gonic/gin.(*Engine).ServeHTTP(0xc0001a69c0, {0x16d5468, 0xc003c5d6c0}, 0xc0093fd900) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/gin.go:576 +0x1aa net/http.serverHandler.ServeHTTP({0xc00aa85e30?}, {0x16d5468?, 0xc003c5d6c0?}, 0x6?) /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:3301 +0x8e net/http.(*conn).serve(0xc005d46120, {0x16d72f0, 0xc001283350}) /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:2102 +0x625 created by net/http.(*Server).Serve in goroutine 134 /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:3454 +0x485 › |
| 2026-10-11 23:23:31.561 · ERROR · cbg-trade · test |
| [dataset.go:92] pet skill not found: 56136, 202610062300113-554-SHSZMAZIABOH, stack: goroutine 986143 [running]: runtime/debug.Stack() /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/runtime/debug/stack.go:26 +0x5e cbg-trade/internal/xlsx.(*dataSet).GetPetSkill(0x10afb20?, {0xc00bb39620, 0x20}, 0xdb48) /root/sources/cbg-value/internal/xlsx/dataset.go:92 +0x9e cbg-trade/internal/report.(*PetSkill).convertNormalSkillNames(0xc001c172b0?, {0xc00bb39620, 0x20}) /root/sources/cbg-value/internal/report/pet_method.go:90 +0x192 cbg-trade/internal/report.(*RoleReport).getPetData(0xc001c172b0, 0xc009126008, 0x20?) /root/sources/cbg-value/internal/report/price.go:558 +0x1e5 cbg-trade/internal/report.(*RoleReport).CreateRoleReportItem(0xc001c172b0, 0xc009126008, 0xc00662b808) /root/sources/cbg-value/internal/report/role_report.go:715 +0x405 cbg-trade/internal/report.(*RoleReport).getFromDetail(0xc001c172b0, 0xc009126008, 0x1) /root/sources/cbg-value/internal/report/role_report.go:303 +0x229 cbg-trade/internal/report.(*RoleReport).GetFromDetail(...) /root/sources/cbg-value/internal/report/role_report.go:272 cbg-trade/internal/apps/value/valueall.(*valueAll).getValue(0x203f980, {0xc009490021, 0x20}, 0xc009126008, 0xc008f49880, 0x0, 0x0, {0x12943db, 0x5}) /root/sources/cbg-value/internal/apps/value/valueall/api.go:94 +0x625 cbg-trade/internal/apps/value/valueall.(*valueAll).GetValueWithDetail(...) /root/sources/cbg-value/internal/apps/value/valueall/api.go:24 cbg-trade/internal/apps/value.(*HttpServer).GetRoleValuation(0xc000e12500, 0xc00146cf00) /root/sources/cbg-value/internal/apps/value/role_value.go:211 +0x16e5 github.com/gin-gonic/gin.(*Context).Next(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 +0x2b cbg-trade/internal/apps/value.NewHttpServer.Cors.func5(0xc00146cf00) /root/sources/cbg-value/internal/utils/cors.go:21 +0xd8 github.com/gin-gonic/gin.(*Context).Next(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 +0x2b cbg-trade/internal/apps/value.NewHttpServer.valuationStatsMiddleware.func4(0xc00146cf00) /root/sources/cbg-value/internal/apps/value/valuation_stats.go:55 +0x24e github.com/gin-gonic/gin.(*Context).Next(...) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 github.com/gin-gonic/gin.CustomRecoveryWithWriter.func1(0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/recovery.go:102 +0x6f github.com/gin-gonic/gin.(*Context).Next(...) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/context.go:174 github.com/gin-gonic/gin.(*Engine).handleHTTPRequest(0xc0001a69c0, 0xc00146cf00) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/gin.go:620 +0x64e github.com/gin-gonic/gin.(*Engine).ServeHTTP(0xc0001a69c0, {0x16d5468, 0xc003c5d6c0}, 0xc0093fd900) /root/go/pkg/mod/github.com/gin-gonic/gin@v1.9.1/gin.go:576 +0x1aa net/http.serverHandler.ServeHTTP({0xc00aa85e30?}, {0x16d5468?, 0xc003c5d6c0?}, 0x6?) /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:3301 +0x8e net/http.(*conn).serve(0xc005d46120, {0x16d72f0, 0xc001283350}) /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:2102 +0x625 created by net/http.(*Server).Serve in goroutine 134 /root/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.24.0.linux-amd64/src/net/http/server.go:3454 +0x485 › |
| 2026-10-11 23:23:30.453 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [1.45 minutes] elapsed › |
| 2026-10-11 23:23:30.441 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success_with_errors 总耗时: 86.653s 角色: 查询 680 / 待处理 640 / 已处理 640 / 成功 323 / 失败 317 / 已标记 4 并发数: 13 吞吐量: 7.39 roles/s 阶段耗时: - 分布式锁: 0.009s - 查询待处理角色: 0.073s - KVrocks状态过滤: 0.054s - 特殊服务器配置加载: 0.000s - worker处理: 84.232s - 飞书通知: 2.283s 调用统计: - KVrocks状态写入: 4次, 累计 0.047s, 平均 0.012s, P50 0.009s, P95 0.011s, P99 0.011s, 最大 0.021s - roledetail: 640次, 累计 391.066s, 平均 0.611s, P50 0.287s, P95 2.063s, P99 5.211s, 最大 11.804s - 基础抽签队列写入: 3次, 累计 0.083s, 平均 0.028s, P50 0.031s, P95 0.031s, P99 0.031s, 最大 0.039s - 审核记录写入: 4次, 累计 0.272s, 平均 0.068s, P50 0.067s, P95 0.069s, P99 0.069s, 最大 0.070s - 服务器查询: 4次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 角色估价: 66次, 累计 468.885s, 平均 7.104s, P50 3.237s, P95 24.515s, P99 31.619s, 最大 39.186s 请求明细: - roledetail HTTP请求: 664 - roledetail超时: 2 - roledetail重试: 24 - roledetail重试成功: 12 - roledetail首次成功: 311 - 代理禁用: 28 worker负载: - worker 1: 25件, 忙碌 75.352s - worker 2: 29件, 忙碌 65.680s - worker 3: 40件, 忙碌 84.230s - worker 4: 39件, 忙碌 55.714s - worker 5: 319件, 忙碌 55.313s - worker 6: 28件, 忙碌 59.432s - worker 7: 25件, 忙碌 68.437s - worker 8: 14件, 忙碌 55.872s - worker 9: 16件, 忙碌 56.080s - worker 10: 22件, 忙碌 72.997s - worker 11: 28件, 忙碌 64.426s - worker 12: 24件, 忙碌 63.879s - worker 13: 31件, 忙碌 82.947s 最慢角色 Top 10: - eid=202609131100113-159-NA9XTKQJUYIT, worker=3, 总耗时=39.780s, roledetail=0.593s, 角色估价=39.186s - eid=202610110000113-9-8ATIJ8MX3QG51V, worker=1, 总耗时=32.706s, roledetail=1.086s, 角色估价=31.619s - eid=202609212300113-554-ZYJTMPFVXKJG, worker=10, 总耗时=29.506s, roledetail=1.262s, 角色估价=28.244s - eid=202610010200113-730-XYN0YJB8QDSZ, worker=13, 总耗时=27.731s, roledetail=1.028s, 角色估价=26.703s - eid=202609271100113-584-F0O3U5CWYK5Z, worker=7, 总耗时=25.838s, roledetail=1.324s, 角色估价=24.515s - eid=202610112200113-554-E5K9UF2EHQ9H, worker=1, 总耗时=18.643s, roledetail=0.443s, 角色估价=18.200s - eid=202610102100113-132-LWCKXUXHJBE9, worker=13, 总耗时=18.436s, roledetail=0.493s, 角色估价=17.943s - eid=202608260800113-407-GBBEKZ4QV9QC, worker=12, 总耗时=17.648s, roledetail=0.599s, 角色估价=17.049s - eid=202610112200113-413-I9EF0NBNHATR, worker=11, 总耗时=17.578s, roledetail=11.804s, 角色估价=5.774s - eid=202608311900113-669-5MPXAS8E97W3, worker=6, 总耗时=17.381s, roledetail=1.090s, 角色估价=16.292s 错误汇总: - roledetail: 317 - 角色处理: 317 =============================================== › |
| 2026-10-11 23:23:28.158 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 640/640 › |