This page acts as a reference guide for queries which often appear when performing ad-hoc analysis.
If collecting traces which including scheduling information (i.e. from ftrace) as well as userspace slices (i.e. from atrace), the actual time spent running on a CPU for each userspace slice can be computed: this is commonly known as the “CPU time” for a slice.
Firstly, setup the views to simplify subsequent queries:
DROP VIEW IF EXISTS slice_with_utid; CREATE VIEW slice_with_utid AS SELECT ts, dur, slice.name as slice_name, slice.id as slice_id, utid, thread.name as thread_name FROM slice JOIN thread_track ON thread_track.id = slice.track_id JOIN thread USING (utid); DROP TABLE IF EXISTS slice_thread_state_breakdown; CREATE VIRTUAL TABLE slice_thread_state_breakdown USING SPAN_LEFT_JOIN( slice_with_utid PARTITIONED utid, thread_state PARTITIONED utid );
Then, to compute the CPU time for all slices in the trace:
SELECT slice_id, slice_name, SUM(dur) AS cpu_time FROM slice_thread_state_breakdown WHERE state = 'Running' GROUP BY slice_id;
You can also compute CPU time for a specific slice:
SELECT slice_name, SUM(dur) AS cpu_time FROM slice_thread_state_breakdown WHERE slice_id = <your slice id> AND state = 'Running';
These queries can be varied easily to compute other similar metrics. For example to get the time spent “runnable” and in “uninterruptible sleep”:
SELECT slice_id, slice_name, SUM(IIF(state = 'R', dur, 0)) AS runnable_time, SUM(IIF(state = 'D', dur, 0)) AS uninterruptible_time FROM slice_thread_state_breakdown GROUP BY slice_id;
A given thread might cause other threads to wake up i.e. because work was scheduled on them. For a given thread, the amount of time threads it woke up ran for can be a good proxy to understand how much work is being spawned.
To compute this, the following query can be used:
SELECT SUM(( SELECT dur FROM sched WHERE sched.ts > wakee_runnable.ts AND wakee_runnable.utid = wakee_runnable.utid ORDER BY ts LIMIT 1 )) AS scheduled_dur FROM thread AS waker JOIN thread_state AS wakee_runnable ON waker.utid = wakee_runnable.waker_utid WHERE waker.name = <your waker thread name here>
To do this for all the threads in the trace simultaenously:
SELECT waker_process.name AS process_name, waker.name AS thread_name, SUM(( SELECT dur FROM sched WHERE sched.ts > wakee_runnable.ts AND sched.utid = wakee_runnable.utid ORDER BY ts LIMIT 1 )) AS scheduled_dur FROM thread AS waker JOIN process AS waker_process USING (upid) JOIN thread_state AS wakee_runnable ON waker.utid = wakee_runnable.waker_utid WHERE waker.utid != 0 GROUP BY 1, 2 ORDER BY 3 desc