system.currenttimemillis()在日志分析中主要起“时间锚点”作用,提供毫秒级时间戳用于事件排序、耗时估算和可观测性,需正确用于请求生命周期记录、日志归档、分位统计,并与nanotime()明确分工。

System.currentTimeMillis() 在日志分析中主要起“时间锚点”作用——它不追求纳秒级精度,但能稳定提供毫秒级时间戳,支撑事件排序、耗时估算和基础可观测性。关键在于用对场景、避开陷阱。
记录请求生命周期,支撑链路追踪
在接口入口(如 Controller 方法第一行)和出口(finally 块中)分别调用 currentTimeMillis(),可计算单次请求耗时:
- 必须覆盖异常路径:很多长尾问题发生在 catch 或 finally 中,漏掉会导致统计失真
- 避免在日志语句里直接拼接:logger.info("cost=" + System.currentTimeMillis() - start),因日志格式化本身有开销,会污染测量结果
- 推荐写法:long start = System.currentTimeMillis(); try { ... } finally { long cost = System.currentTimeMillis() - start; record(cost); }
生成可排序的时间戳,用于日志归档与排查
它返回的是自 Unix 纪元起的毫秒数,天然支持按数值大小排序,适合:
- 跨服务日志对齐(配合 traceId):虽不能精确到微秒,但对秒级或百毫秒级问题定位已足够
- 按小时/天切分日志文件:如 logs/app-20260609.log,文件名中嵌入日期,内部每条日志带毫秒时间戳
- 快速筛选“某时间段内发生的错误”:数据库或 ELK 中用 timestamp 字段范围查询,响应快、索引友好
辅助识别长尾与抖动,但需搭配分位数统计
单独看平均耗时意义有限。真正有价值的是从大量 currentTimeMillis() 打点数据中提取 P95、P99 等分位值:
- 高频接口建议本地聚合:用 HdrHistogram 或滑动窗口在内存中实时计算,避免全量落盘压力
- 采样要保长尾:固定比例随机采样 + 超阈值强制采样(如 >1s 请求必记),防止慢请求被淹没
- 注意时钟漂移干扰:若发现大量负耗时或突增耗时,先检查宿主机 NTP 同步状态与时钟偏移告警
和 nanoTime() 划清边界,不混用
currentTimeMillis() 是“什么时候”,nanoTime() 是“多久”。日志分析中:
- 用 currentTimeMillis() 记录事件发生时刻(如“订单创建时间”“缓存失效时间”)
- 用 nanoTime() 做方法级微基准测试(如 DAO 层 SQL 执行耗时),但结果不进业务日志,只用于 JMH 报告
- 禁止用 nanoTime() 值做超时判断或写入数据库时间字段——它无业务时间语义,也不能转成可读日期











