| 2026-08-28 02:38:23.775 · INFO · cbg-trade · test |
| [main.go:59] Server exit, [0.27 minutes] elapsed › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:147] [sub_check_ordered] ordered item 4/5: name="持国巡守" eid=202608280100113-229-5BGDYPARB8BO random_draw_finish_time=2026-08-28 02:41:10 › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:145] [sub_check_ordered] ordered item details: count=5 › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:147] [sub_check_ordered] ordered item 3/5: name="上古玉魄·阴" eid=202608280100113-459-EHISDR2MCBSZ random_draw_finish_time=2026-08-28 02:40:41 › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:147] [sub_check_ordered] ordered item 2/5: name="明月珰" eid=202608280100113-459-KLDTFMSNORAR random_draw_finish_time=2026-08-28 02:39:43 › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:147] [sub_check_ordered] ordered item 1/5: name="明月珰" eid=202608280100113-6-ZLXHKJVYFZ0QBH random_draw_finish_time=2026-08-28 02:39:19 › |
| 2026-08-28 02:38:23.769 · INFO · cbg-trade · test |
| [subcheck.go:147] [sub_check_ordered] ordered item 5/5: name="日游神" eid=202608280100113-199-4HRCXJXWQTRW random_draw_finish_time=2026-08-28 02:43:01 › |
| 2026-08-28 02:38:23.513 · INFO · cbg-trade · test |
| [update.go:136] [7/64] worker 4 check count 0, eid: 202608280100113-266-J5BM7PRPR4RC, status 2 › |
| 2026-08-28 02:38:23.438 · INFO · cbg-trade · test |
| [update.go:136] [6/64] worker 2 check count 0, eid: 202608280100113-926-RHXGDDRW5OP8, status 2 › |
| 2026-08-28 02:38:23.268 · INFO · cbg-trade · test |
| [update.go:138] [5/64] worker 4 check count 0, eid: 202608280100113-9-VXM2ROMQGXX6BA, status 2->3 › |
| 2026-08-28 02:38:22.957 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check_ordered] progress: processed=263/263 waiting=258 ordered=5 pushed=0 errors=0 › |
| 2026-08-28 02:38:22.957 · INFO · cbg-trade · test |
| [subcheck.go:376] [sub_check_ordered] completed: processed=263/263 waiting=258 ordered=5 pushed=0 errors=0 › |
| 2026-08-28 02:38:22.957 · INFO · cbg-trade · test |
| [report.go:161] ========== SubCheck 卡顿分析报告 ========== 结果: success 总耗时: 15.168s 物品: 查询 263 / 待处理 263 / 已处理 263 / 成功 5 / 失败 258 并发数: 4 历史归档: 0 吞吐量: 17.34 items/s 阶段耗时: - 查询待处理物品: 0.081s - KVrocks状态过滤: 0.007s - 订阅基础数据加载: 0.078s - 订阅规则加载: 0.964s - worker处理: 14.033s - 邮件发送: 0.000s 调用统计: - KVrocks状态写入: 5次, 累计 0.055s, 平均 0.011s, P50 0.013s, P95 0.013s, P99 0.013s, 最大 0.018s - itemdetail: 263次, 累计 55.546s, 平均 0.211s, P50 0.149s, P95 0.375s, P99 2.160s, 最大 2.808s - 估价: 5次, 累计 0.280s, 平均 0.056s, P50 0.018s, P95 0.019s, P99 0.019s, 最大 0.216s - 订阅匹配与推送: 5次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s - 订阅规则匹配: 4次, 累计 0.000s, 平均 0.000s, P50 0.000s, P95 0.000s, P99 0.000s, 最大 0.000s worker负载: - worker 1: 59件, 忙碌 13.967s - worker 2: 74件, 忙碌 14.031s - worker 3: 66件, 忙碌 13.944s - worker 4: 64件, 忙碌 13.947s 最慢物品 Top 10: - eid=202608280100113-159-6LSHZIELTZZM, worker=3, 总耗时=2.808s, itemdetail=2.808s, 物品处理=2.808s - eid=202608280100113-299-NZ4PZUCIZKVK, worker=4, 总耗时=2.668s, itemdetail=2.668s, 物品处理=2.668s - eid=202608261100113-443-TQNYR24WV1LF, worker=2, 总耗时=2.313s, itemdetail=2.313s, 物品处理=2.313s - eid=202608280100113-558-LYCVV6F26VAH, worker=2, 总耗时=2.160s, itemdetail=2.160s, 物品处理=2.160s - eid=202608280100113-926-RHXGDDRW5OP8, worker=1, 总耗时=2.083s, itemdetail=2.083s, 物品处理=2.083s - eid=202608280100113-352-YIXFCEOZNFVO, worker=3, 总耗时=1.176s, itemdetail=1.176s, 物品处理=1.176s - eid=202608280100113-579-YL9VX7RNJPYU, worker=4, 总耗时=1.016s, itemdetail=1.016s, 物品处理=1.016s - eid=202608280100113-215-BOXSDPF0FKQC, worker=1, 总耗时=0.970s, itemdetail=0.970s, 物品处理=0.970s - eid=202608280100113-60-EMKDIX7BM96UJ, worker=1, 总耗时=0.492s, itemdetail=0.492s, 物品处理=0.492s - eid=202608280100113-932-T9VL890Y83FO, worker=4, 总耗时=0.489s, itemdetail=0.489s, 物品处理=0.489s =========================================== › |
| 2026-08-28 02:38:22.931 · INFO · cbg-trade · test |
| [update.go:136] [1/64] worker 2 check count 0, eid: 202608280100113-215-PZVNAGQMDTP6, status 2 › |
| 2026-08-28 02:38:22.920 · INFO · cbg-trade · test |
| [update.go:136] [2/64] worker 4 check count 0, eid: 202608280100113-459-BUTTEIG0SGMP, status 2 › |
| 2026-08-28 02:38:22.872 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check_ordered] progress: processed=260/263 waiting=255 ordered=5 pushed=0 errors=0 › |
| 2026-08-28 02:38:22.563 · INFO · cbg-trade · test |
| [eidtype.go:87] [eid_type] upstream lookup succeeded, eid=202608020100113-584-EHYJWXLS0SNL server_id=584 reason=value status=1 status_code=OK kind_id=20 equip_type=2913 listing_status=2 › |
| 2026-08-28 02:38:22.500 · INFO · cbg-trade · test |
| [single_line.go:146] [sub_check_ordered] ordered item found: eid=202608280100113-199-4HRCXJXWQTRW server_id=199 status=3 › |
| 2026-08-28 02:38:22.424 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check_ordered] progress: processed=250/263 waiting=246 ordered=4 pushed=0 errors=0 › |
| 2026-08-28 02:38:22.161 · INFO · cbg-trade · test |
| [update.go:170] updating 64 random push reviews with 4 workers › |