[Android systrace系列] systrace时间戳与手机时间的对应关系

一般用systrace分析问题，我们直接查看关注的流程即可。

有时logcat提供了重要的信息，但这些信息没有用systrace log输出。

如果我们能将systrace时间与手机时间对应起来，就不用添加systrace log重新编译手机ROM了。

----------------------------------------------------------------------------------

这篇文章的小目标：

1. 计算systrace时间与手机时间的对应关系

2. 在自己的代码中添加systrace log

---------------------------------------------------

 

这里存在三个时间戳，

1）systrace时间轴上的时间，时间轴从0开始算起，以毫秒为单位

2）kernel 时间，记录kernel开始启动后流逝的时间，以秒为单位

3）系统时钟，显示当时几点钟，也就是system log的时间

 

要找到systrace时间与kernel时间的对应关系，非常简单，只需要以纯文本方式打开systrace的html文件，搜"TIMESTAMP  FUNCTION"，第一句log显示的kernel时间，就对应着systrace时间轴的起始时间。

我们用一个真实的trace文件来算一下，下面是第一句log

<...>-8634  (-----) [001] ...1 944990.442341: tracing_mark_write: trace_event_clock_sync: parent_ts=80241.648438

这里的944990.442341是kernel log时间，同时也是systrace时间轴的起始时间。

 

我们用下面截图，算出DrawFrame流程的开始时的kernel时间，由于单位不同，这里systrace时间戳需要转换单位为秒。

 

我们用纯文本打开trace文件看看是不是：

RenderThread-8555  ( 8508) [002] ...1 944997.124754: tracing_mark_write: B|8508|DrawFrame

这里的误差是毫秒以内的，一般足够了。

 

 

我们再来找kernel log时间与系统system log时间的对应关系。

每个厂商或许都有各自的log对照，这里使用一个浅显的方法来对照。

思路是在app中以systrace log的方式，输出当前系统时间，再用systrace来看。

首先要介绍添加systrace log的方法，按照惯例，我引用官方文档：

https://developer.android.google.cn/studio/profile/systrace/custom-events?hl=zh-cn

这个文档，说明了在自己代码添加systrace log，测量耗时的方法。

 

看完如何加log的文档，言归正传，我们在Hello world app上加上一个按钮，一点按钮就打systrace log，我们这里用Time align作为关键字。

package nothing.example;import android.os.Bundle;import android.os.Trace;import android.view.View;import android.widget.Button;import androidx.appcompat.app.AppCompatActivity;public class MainActivity extends AppCompatActivity { @Override protected void onCreate(Bundle savedInstanceState) {  super.onCreate(savedInstanceState);  setContentView(R.layout.activity_main);  Button TimeAlignButton = findViewById(R.id.TimeAlignButton);  TimeAlignButton.setOnClickListener(new View.OnClickListener() {   @Override   public void onClick(View view) {    long totalMilliSeconds = System.currentTimeMillis();    long totalSeconds = totalMilliSeconds / 1000;    long currentSecond = totalSeconds % 60;    long totalMinutes = totalSeconds / 60;    long currentMinute = totalMinutes % 60;    //中国时区是东八区，所以+8    long totalHour = totalMinutes / 60 + 8;    long currentHour = totalHour % 24;    long ms = totalMilliSeconds % 1000;    Trace.beginSection("Time align " + currentHour + ":" + currentMinute + ":" + currentSecond + "." + ms);    Trace.endSection();   }  }); }}

 

接下来我们抓取点击按钮操作的systrace，按照 [Android systrace系列] systrace入门第一式 的方法，把app输出的systrace log抓到。

需要留心的是，因为这里需要抓app的systrace log，所以需要userdebug版本的手机。

python systrace.py -o mynewtrace.html -a nothing.example

纯文本打开mynewtrace.html，搜索Time align，kernel时间1434.981241和系统时钟15:11:32.537就对上了。

nothing.exampl-7676  ( 7676) [000] ...1  1434.981241: tracing_mark_write: B|7676|Time align 15:11:32.537

 

小目标，完成。

 

 

转载请注明出处：https://www.cnblogs.com/zzcperf/p/14008147.html

原文转载：http://www.shaoqun.com/a/493347.html

skyee：https://www.ikjzd.com/w/290

海淘贝：https://www.ikjzd.com/w/1726

lithium：https://www.ikjzd.com/w/2505

一般用systrace分析问题，我们直接查看关注的流程即可。有时logcat提供了重要的信息，但这些信息没有用systracelog输出。如果我们能将systrace时间与手机时间对应起来，就不用添加systracelog重新编译手机ROM了。------------------------------------------------------------------------------
急速：急速
启明星：启明星
冬天去峨眉山好玩吗 ：冬天去峨眉山好玩吗
去德国旅游要多少钱 2020德国旅游注意事项：去德国旅游要多少钱 2020德国旅游注意事项
三亚168海鲜加工店 ：三亚168海鲜加工店