[venus-worker] request received和request done 日志增加具体的sectorNum

[alisazhang777]

模块 / Components

• venus-sector-manager
• venus-worker
• 工具链 / toolchains
• 文档 / docs

描述 / Description

现状：p2阶段的pid和p1阶段的pid是不同的，无法统计同一个扇区p1结束的时间和p2开始的时间，只能统计不同扇区的单个阶段时间。

建议：每个任务request received和request done 日志里增加具体的sectorNum，为了便于查看任务调度（即同一个任务上一个阶段结束和下一个阶段开始的时间）。
当前日志：

2022-07-24T14:29:16.206698598+08:00 DEBUG ThreadId(04) sub{name="PC1" pid=xxx}:request{id=2 size=682}: vc_processors::core::ext::consumer: request received
                                                    
2022-07-24T14:29:16.206862453+08:00 DEBUG ThreadId(05) sub{name="PC1" pid=xxx}:request{id=3 size=682}: vc_processors::core::ext::consumer: request done

优化后的日志：

2022-07-24T14:29:16.206698598+08:00 DEBUG ThreadId(04) sub{SectorNum（xxx），name="PC1" pid=xxx}:request{id=2 size=682}: vc_processors::core::ext::consumer: request received
                                                       
2022-07-24T14:29:16.206862453+08:00 DEBUG ThreadId(05) sub{SectorNum（xxx），name="PC1" pid=xxx}:request{id=3 size=682}: vc_processors::core::ext::consumer: request done
                                                 

[0x5459]

这个地方不太方便加 SectorNum. 可能在 worker planner 相关的地方加上？
cc @dtynn

[dtynn]

这个地方不太方便加 SectorNum. 可能在 worker planner 相关的地方加上？ cc @dtynn

几种方案思路：

1. 为Processor 的调用入口增加耗时统计的日志，然后利用 tracing span 携带额外的上下文
2. 直接统计对应的扇区和其某两个状态转换之间的间隔时间
3. 在worker planner 中的各个阶段逻辑中手工编码计时逻辑

优雅程度递减

[dtynn]

应该是类似

impl SealerPlaner {
    fn handle_some() {
        let sector_id = ...;
        let params = ...;
        let _span = warn_span!("process", ?sector_id).entered();
        let res = ctx.global.processors.pc2.exec(params).perm()?;
    }
}

这样的思路。
计时的 log 在这里的 exec 中

这样并不需要一路将 sector id 向下传递

[elvin-du]

运维优先级非常高。
运维的需求是：VSM中扇区各个阶段的时间，打印在日志中。

[0x5459]

这个暂时不做。 准备实现这个 #768

[elvin-du]

采用数据库方案。#443