| 2026-08-29 02:02:59.904 · INFO · cbg-trade · test |
| [report.go:221] ========== NewRoleCheck 卡顿分析报告 ========== 结果: success 总耗时: 46.971s 角色: 查询 240 / 待处理 226 / 已处理 226 / 成功 226 / 失败 0 / 已标记 0 并发数: 8 吞吐量: 4.81 roles/s 阶段耗时: - 分布式锁: 0.024s - 查询待处理角色: 0.079s - KVrocks状态过滤: 0.012s - 特殊服务器配置加载: 0.000s - worker处理: 45.712s - 飞书通知: 1.144s 调用统计: - roledetail: 226次, 累计 245.707s, 平均 1.087s, P50 0.595s, P95 2.540s, P99 11.693s, 最大 12.819s - 角色估价: 53次, 累计 79.214s, 平均 1.495s, P50 0.965s, P95 4.119s, P99 6.844s, 最大 7.918s 请求明细: - roledetail HTTP请求: 234 - roledetail超时: 6 - roledetail重试: 8 - roledetail重试成功: 7 - roledetail首次成功: 219 - 代理禁用: 8 worker负载: - worker 1: 31件, 忙碌 40.139s - worker 2: 43件, 忙碌 38.737s - worker 3: 22件, 忙碌 42.059s - worker 4: 21件, 忙碌 45.711s - worker 5: 16件, 忙碌 39.283s - worker 6: 57件, 忙碌 39.692s - worker 7: 9件, 忙碌 39.910s - worker 8: 27件, 忙碌 39.393s 最慢角色 Top 10: - eid=202608290000113-926-C14QJB9ZBCDF, worker=7, 总耗时=18.492s, roledetail=11.648s, 角色估价=6.844s - eid=202608290100113-838-MAFBJXAOB1RV, worker=4, 总耗时=12.819s, roledetail=12.819s - eid=202508271400113-416-XPQFBOEMBUSY, worker=3, 总耗时=12.250s, roledetail=12.250s - eid=202606132200113-807-W9GH5HUINPOJ, worker=5, 总耗时=11.730s, roledetail=11.730s - eid=202608210900113-583-UZVLAVUVXIEF, worker=7, 总耗时=11.693s, roledetail=11.693s - eid=202608290100113-420-IHA8LNJEYSNZ, worker=3, 总耗时=11.308s, roledetail=11.308s - eid=202606291600113-554-JR8TJ6FOAGCP, worker=4, 总耗时=9.018s, roledetail=1.100s, 角色估价=7.918s - eid=202608290100113-358-MGNQRW18AH4Z, worker=5, 总耗时=8.241s, roledetail=8.241s - eid=202608290000113-926-CD3LVOBWSFJS, worker=8, 总耗时=7.174s, roledetail=2.798s, 角色估价=4.376s - eid=202607211300113-669-Q7A0DB3EADIN, worker=1, 总耗时=4.707s, roledetail=0.588s, 角色估价=4.119s =============================================== › |
| 2026-08-29 02:02:58.760 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 226/226 › |
| 2026-08-29 02:02:58.437 · INFO · cbg-item · test |
| [cache.go:351] flush status update batch table=pet_4 size=500 › |
| 2026-08-29 02:02:58.436 · INFO · cbg-item · test |
| [cache.go:312] status update cache clickhouse batch updated table=pet_4 batch_size=500 first_eid=202608212200113-926-LV9KURLNQZPF last_eid=202608212300113-625-2LZHZUGDRZLD › |
| 2026-08-29 02:02:56.627 · INFO · cbg-trade · test |
| [random_push_review.go:175] role get random push review, token: SLMN-VFYT-6778-4481 › |
| 2026-08-29 02:02:55.200 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=400/509 waiting=0 ordered=0 pushed=52 errors=0 › |
| 2026-08-29 02:02:54.704 · INFO · cbg-trade · test |
| [eidtype.go:87] [eid_type] upstream lookup succeeded, eid=202607052200113-554-0EXTM2XU2XTA server_id=554 reason=value status=1 status_code=OK kind_id=63 equip_type=27204 listing_status=2 › |
| 2026-08-29 02:02:52.741 · INFO · cbg-item · test |
| [cache.go:351] flush status update batch table=pet_4 size=500 › |
| 2026-08-29 02:02:52.618 · INFO · cbg-item · test |
| [cache.go:312] status update cache clickhouse batch updated table=pet_4 batch_size=500 first_eid=202608212200113-192-1EVJ7ZZUW5AI last_eid=202608212200113-926-J2YA5CMEUGF9 › |
| 2026-08-29 02:02:52.618 · INFO · cbg-item · test |
| [cache.go:269] status update cache flush table progress table=pet_4 flushed=14000 failed=0 pending_start=15627 › |
| 2026-08-29 02:02:49.752 · INFO · cbg-trade · test |
| [eidtype.go:87] [eid_type] upstream lookup succeeded, eid=202608180900113-554-FIH8WHIHEP81 server_id=554 reason=value status=1 status_code=OK kind_id=63 equip_type=27202 listing_status=2 › |
| 2026-08-29 02:02:49.499 · INFO · cbg-trade · test |
| [single_line.go:49] new role check progress: 200/226 › |
| 2026-08-29 02:02:46.809 · WARN · cbg-trade · test |
| [httpclient.go:165] Failed to read response body: context deadline exceeded (Client.Timeout or context cancellation while reading body) › |
| 2026-08-29 02:02:46.789 · INFO · cbg-item · test |
| [cache.go:351] flush status update batch table=pet_4 size=500 › |
| 2026-08-29 02:02:46.788 · INFO · cbg-item · test |
| [cache.go:312] status update cache clickhouse batch updated table=pet_4 batch_size=500 first_eid=202608212100113-249-85XRT7VLW2MG last_eid=202608212200113-173-XMTDHFATFCEW › |
| 2026-08-29 02:02:45.327 · INFO · cbg-trade · test |
| [single_line.go:57] [sub_check] progress: processed=300/509 waiting=0 ordered=0 pushed=34 errors=0 › |
| 2026-08-29 02:02:44.861 · WARN · cbg-trade · test |
| [httpclient.go:165] Failed to read response body: context deadline exceeded (Client.Timeout or context cancellation while reading body) › |
| 2026-08-29 02:02:44.774 · INFO · cbg-trade · test |
| [eidtype.go:87] [eid_type] upstream lookup succeeded, eid=202606141700113-554-HZVRCMVH6SSL server_id=554 reason=value status=1 status_code=OK kind_id=63 equip_type=27204 listing_status=2 › |
| 2026-08-29 02:02:41.290 · WARN · cbg-trade · test |
| [httpclient.go:165] Failed to read response body: context deadline exceeded (Client.Timeout or context cancellation while reading body) › |
| 2026-08-29 02:02:41.181 · INFO · cbg-item · test |
| [cache.go:351] flush status update batch table=pet_4 size=500 › |