Perfetto log 与解析

从抓Perfetto log 到log的解析，Perfetto 与systrace log有很大的不同。Perfetto把很多系统级的log如单个进程的memory/GPU ion/adj/native/java memory debug/proc/stat /logcat/CPU freq/CPU 调度/CPU C stat/power 电压/电池的使用/syscall 等merge 在一起，一并在UI 上显示出来，可以观察到引起系统性能的各个因数。不夸张的说，如果能看懂Perfetto 在抓log界面里面设置每一项是什么意思，能抓到哪些log，那么你对性能的调试可以算已经入门，否则，需要进一步学习。

从Perfetto UI 抓取 Perfetto log

Buffer size /duration

CPU

GPU

Power：

Memroy：

也可以在手机上手动执行抓perfetto log

adb shell perfetto \

-c - --txt \

-o/data/misc/perfetto-traces/trace \

<<EOF

buffers: {

size_kb: 63488

fill_policy:DISCARD

}

buffers: {

size_kb: 2048

fill_policy:DISCARD

}

data_sources: {

config {

name:"android.gpu.memory"

}

}

data_sources: {

config {

name:"android.power"

android_power_config {

battery_poll_ms: 1000

battery_counters: BATTERY_COUNTER_CAPACITY_PERCENT

battery_counters: BATTERY_COUNTER_CHARGE

battery_counters: BATTERY_COUNTER_CURRENT

collect_power_rails: true

}

}

}

data_sources: {

config {

name:"linux.process_stats"

target_buffer:1

process_stats_config {

scan_all_processes_on_start: true

proc_stats_poll_ms: 1000

}

}

}

data_sources: {

config {

name:"android.log"

android_log_config {

}

}

}

data_sources: {

config {

name:"linux.sys_stats"

sys_stats_config {

meminfo_period_ms: 1000

meminfo_counters: MEMINFO_MEM_TOTAL

meminfo_counters: MEMINFO_MEM_FREE

meminfo_counters: MEMINFO_MEM_AVAILABLE

meminfo_counters: MEMINFO_BUFFERS

meminfo_counters: MEMINFO_CACHED

meminfo_counters: MEMINFO_SWAP_CACHED

meminfo_counters: MEMINFO_ACTIVE

meminfo_counters: MEMINFO_INACTIVE

meminfo_counters: MEMINFO_ACTIVE_ANON

meminfo_counters: MEMINFO_INACTIVE_ANON

meminfo_counters: MEMINFO_ACTIVE_FILE

meminfo_counters: MEMINFO_INACTIVE_FILE

meminfo_counters: MEMINFO_UNEVICTABLE

meminfo_counters: MEMINFO_MLOCKED

meminfo_counters: MEMINFO_SWAP_TOTAL

meminfo_counters: MEMINFO_SWAP_FREE

meminfo_counters: MEMINFO_DIRTY

meminfo_counters: MEMINFO_WRITEBACK

meminfo_counters: MEMINFO_ANON_PAGES

meminfo_counters: MEMINFO_MAPPED

meminfo_counters: MEMINFO_SHMEM

meminfo_counters: MEMINFO_SLAB

meminfo_counters: MEMINFO_SLAB_RECLAIMABLE

meminfo_counters: MEMINFO_SLAB_UNRECLAIMABLE

meminfo_counters: MEMINFO_KERNEL_STACK

meminfo_counters: MEMINFO_PAGE_TABLES

meminfo_counters: MEMINFO_COMMIT_LIMIT

meminfo_counters: MEMINFO_COMMITED_AS

meminfo_counters: MEMINFO_VMALLOC_TOTAL

meminfo_counters: MEMINFO_VMALLOC_USED

meminfo_counters: MEMINFO_VMALLOC_CHUNK

meminfo_counters: MEMINFO_CMA_TOTAL

meminfo_counters: MEMINFO_CMA_FREE

vmstat_period_ms: 1000

vmstat_counters: VMSTAT_NR_FREE_PAGES

vmstat_counters: VMSTAT_NR_ALLOC_BATCH

vmstat_counters: VMSTAT_NR_INACTIVE_ANON

vmstat_counters: VMSTAT_NR_ACTIVE_ANON

vmstat_counters: VMSTAT_NR_INACTIVE_FILE

vmstat_counters: VMSTAT_NR_ACTIVE_FILE

vmstat_counters: VMSTAT_NR_UNEVICTABLE

vmstat_counters: VMSTAT_NR_MLOCK

vmstat_counters: VMSTAT_NR_ANON_PAGES

vmstat_counters: VMSTAT_NR_MAPPED

vmstat_counters: VMSTAT_NR_FILE_PAGES

vmstat_counters: VMSTAT_NR_DIRTY

vmstat_counters: VMSTAT_NR_WRITEBACK

vmstat_counters:VMSTAT_NR_SLAB_RECLAIMABLE

vmstat_counters: VMSTAT_NR_SLAB_UNRECLAIMABLE

vmstat_counters: VMSTAT_NR_PAGE_TABLE_PAGES

vmstat_counters: VMSTAT_NR_KERNEL_STACK

vmstat_counters: VMSTAT_NR_OVERHEAD

vmstat_counters: VMSTAT_NR_UNSTABLE

vmstat_counters: VMSTAT_NR_BOUNCE

vmstat_counters: VMSTAT_NR_VMSCAN_WRITE

vmstat_counters: VMSTAT_NR_VMSCAN_IMMEDIATE_RECLAIM

vmstat_counters: VMSTAT_NR_WRITEBACK_TEMP

vmstat_counters: VMSTAT_NR_ISOLATED_ANON

vmstat_counters: VMSTAT_NR_ISOLATED_FILE

vmstat_counters: VMSTAT_NR_SHMEM

vmstat_counters: VMSTAT_NR_DIRTIED

vmstat_counters: VMSTAT_NR_WRITTEN

vmstat_counters: VMSTAT_NR_PAGES_SCANNED

vmstat_counters: VMSTAT_WORKINGSET_REFAULT

vmstat_counters: VMSTAT_WORKINGSET_ACTIVATE

vmstat_counters: VMSTAT_WORKINGSET_NODERECLAIM

vmstat_counters: VMSTAT_NR_ANON_TRANSPARENT_HUGEPAGES

vmstat_counters: VMSTAT_NR_FREE_CMA

vmstat_counters: VMSTAT_NR_SWAPCACHE

vmstat_counters: VMSTAT_NR_DIRTY_THRESHOLD

vmstat_counters: VMSTAT_NR_DIRTY_BACKGROUND_THRESHOLD

vmstat_counters: VMSTAT_PGPGIN

vmstat_counters: VMSTAT_PGPGOUT

vmstat_counters: VMSTAT_PGPGOUTCLEAN

vmstat_counters: VMSTAT_PSWPIN

vmstat_counters: VMSTAT_PSWPOUT

vmstat_counters: VMSTAT_PGALLOC_DMA

vmstat_counters: VMSTAT_PGALLOC_NORMAL

vmstat_counters: VMSTAT_PGALLOC_MOVABLE

vmstat_counters: VMSTAT_PGFREE

vmstat_counters: VMSTAT_PGACTIVATE

vmstat_counters: VMSTAT_PGDEACTIVATE

vmstat_counters: VMSTAT_PGFAULT

vmstat_counters: VMSTAT_PGMAJFAULT

vmstat_counters: VMSTAT_PGREFILL_DMA

vmstat_counters: VMSTAT_PGREFILL_NORMAL

vmstat_counters: VMSTAT_PGREFILL_MOVABLE

vmstat_counters: VMSTAT_PGSTEAL_KSWAPD_DMA

vmstat_counters: VMSTAT_PGSTEAL_KSWAPD_NORMAL

vmstat_counters: VMSTAT_PGSTEAL_KSWAPD_MOVABLE

vmstat_counters: VMSTAT_PGSTEAL_DIRECT_DMA

vmstat_counters: VMSTAT_PGSTEAL_DIRECT_NORMAL

vmstat_counters: VMSTAT_PGSTEAL_DIRECT_MOVABLE

vmstat_counters: VMSTAT_PGSCAN_KSWAPD_DMA

vmstat_counters: VMSTAT_PGSCAN_KSWAPD_NORMAL

vmstat_counters: VMSTAT_PGSCAN_KSWAPD_MOVABLE

vmstat_counters: VMSTAT_PGSCAN_DIRECT_DMA

vmstat_counters: VMSTAT_PGSCAN_DIRECT_NORMAL

vmstat_counters: VMSTAT_PGSCAN_DIRECT_MOVABLE

vmstat_counters: VMSTAT_PGSCAN_DIRECT_THROTTLE

vmstat_counters: VMSTAT_PGINODESTEAL

vmstat_counters: VMSTAT_SLABS_SCANNED

vmstat_counters: VMSTAT_KSWAPD_INODESTEAL

vmstat_counters:VMSTAT_KSWAPD_LOW_WMARK_HIT_QUICKLY

vmstat_counters: VMSTAT_KSWAPD_HIGH_WMARK_HIT_QUICKLY

vmstat_counters: VMSTAT_PAGEOUTRUN

vmstat_counters: VMSTAT_ALLOCSTALL

vmstat_counters: VMSTAT_PGROTATED

vmstat_counters:VMSTAT_DROP_PAGECACHE

vmstat_counters: VMSTAT_DROP_SLAB

vmstat_counters: VMSTAT_PGMIGRATE_SUCCESS

vmstat_counters: VMSTAT_PGMIGRATE_FAIL

vmstat_counters: VMSTAT_COMPACT_MIGRATE_SCANNED

vmstat_counters: VMSTAT_COMPACT_FREE_SCANNED

vmstat_counters: VMSTAT_COMPACT_ISOLATED

vmstat_counters: VMSTAT_COMPACT_STALL

vmstat_counters: VMSTAT_COMPACT_FAIL

vmstat_counters: VMSTAT_COMPACT_SUCCESS

vmstat_counters: VMSTAT_COMPACT_DAEMON_WAKE

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_CULLED

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_SCANNED

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_RESCUED

vmstat_counters:VMSTAT_UNEVICTABLE_PGS_MLOCKED

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_MUNLOCKED

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_CLEARED

vmstat_counters: VMSTAT_UNEVICTABLE_PGS_STRANDED

vmstat_counters: VMSTAT_NR_ZSPAGES

vmstat_counters: VMSTAT_NR_ION_HEAP

vmstat_counters: VMSTAT_NR_GPU_HEAP

vmstat_counters: VMSTAT_ALLOCSTALL_DMA

vmstat_counters:VMSTAT_ALLOCSTALL_MOVABLE

vmstat_counters: VMSTAT_ALLOCSTALL_NORMAL

vmstat_counters: VMSTAT_COMPACT_DAEMON_FREE_SCANNED

vmstat_counters: VMSTAT_COMPACT_DAEMON_MIGRATE_SCANNED

vmstat_counters:VMSTAT_NR_FASTRPC

vmstat_counters: VMSTAT_NR_INDIRECTLY_RECLAIMABLE

vmstat_counters: VMSTAT_NR_ION_HEAP_POOL

vmstat_counters: VMSTAT_NR_KERNEL_MISC_RECLAIMABLE

vmstat_counters: VMSTAT_NR_SHADOW_CALL_STACK_BYTES

vmstat_counters: VMSTAT_NR_SHMEM_HUGEPAGES

vmstat_counters: VMSTAT_NR_SHMEM_PMDMAPPED

vmstat_counters: VMSTAT_NR_UNRECLAIMABLE_PAGES

vmstat_counters: VMSTAT_NR_ZONE_ACTIVE_ANON

vmstat_counters:VMSTAT_NR_ZONE_ACTIVE_FILE

vmstat_counters: VMSTAT_NR_ZONE_INACTIVE_ANON

vmstat_counters: VMSTAT_NR_ZONE_INACTIVE_FILE

vmstat_counters: VMSTAT_NR_ZONE_UNEVICTABLE

vmstat_counters: VMSTAT_NR_ZONE_WRITE_PENDING

vmstat_counters: VMSTAT_OOM_KILL

vmstat_counters: VMSTAT_PGLAZYFREE

vmstat_counters: VMSTAT_PGLAZYFREED

vmstat_counters: VMSTAT_PGREFILL

vmstat_counters: VMSTAT_PGSCAN_DIRECT

vmstat_counters: VMSTAT_PGSCAN_KSWAPD

vmstat_counters: VMSTAT_PGSKIP_DMA

vmstat_counters: VMSTAT_PGSKIP_MOVABLE

vmstat_counters: VMSTAT_PGSKIP_NORMAL

vmstat_counters: VMSTAT_PGSTEAL_DIRECT

vmstat_counters: VMSTAT_PGSTEAL_KSWAPD

vmstat_counters: VMSTAT_SWAP_RA

vmstat_counters: VMSTAT_SWAP_RA_HIT

stat_period_ms: 1000

stat_counters: STAT_CPU_TIMES

stat_counters: STAT_FORK_COUNT

}

}

}

data_sources: {

config {

name:"android.heapprofd"

target_buffer:0

heapprofd_config {

sampling_interval_bytes: 4096

shmem_size_bytes: 8388608

block_client: true

}

}

}

data_sources: {

config {

name:"android.java_hprof"

target_buffer:0

java_hprof_config {

}

}

}

data_sources: {

config {

name:"linux.ftrace"

ftrace_config{

ftrace_events: "binder/*"

ftrace_events: "block/*"

ftrace_events: "clk/*"

ftrace_events: "ext4/*"

ftrace_events: "f2fs/*"

ftrace_events:"i2c/*"

ftrace_events: "irq/*"

ftrace_events: "kmem/*"

ftrace_events: "memory_bus/*"

ftrace_events: "mmc/*"

ftrace_events: "oom/*"

ftrace_events: "power/*"

ftrace_events:"regulator/*"

ftrace_events: "sched/*"

ftrace_events: "sync/*"

ftrace_events: "task/*"

ftrace_events: "vmscan/*"

ftrace_events: "fastrpc/*"

ftrace_events: "sched/sched_switch"

ftrace_events:"power/suspend_resume"

ftrace_events: "sched/sched_wakeup"

ftrace_events: "sched/sched_wakeup_new"

ftrace_events: "sched/sched_waking"

ftrace_events: "power/cpu_frequency"

ftrace_events: "power/cpu_idle"

ftrace_events: "power/gpu_frequency"

ftrace_events: "gpu_mem/gpu_mem_total"

ftrace_events: "raw_syscalls/sys_enter"

ftrace_events:"raw_syscalls/sys_exit"

ftrace_events: "sched/sched_process_exit"

ftrace_events: "sched/sched_process_free"

ftrace_events: "task/task_newtask"

ftrace_events: "task/task_rename"

ftrace_events:"regulator/regulator_set_voltage"

ftrace_events: "regulator/regulator_set_voltage_complete"

ftrace_events: "power/clock_enable"

ftrace_events: "power/clock_disable"

ftrace_events: "power/clock_set_rate"

ftrace_events: "mm_event/mm_event_record"

ftrace_events: "kmem/rss_stat"

ftrace_events: "ion/ion_stat"

ftrace_events: "kmem/ion_heap_grow"

ftrace_events: "kmem/ion_heap_shrink"

ftrace_events:"lowmemorykiller/lowmemory_kill"

ftrace_events: "oom/oom_score_adj_update"

ftrace_events: "ftrace/print"

atrace_categories: "gfx"

atrace_categories: "input"

atrace_categories: "view"

atrace_categories: "webview"

atrace_categories: "wm"

atrace_categories: "am"

atrace_categories: "sm"

atrace_categories: "audio"

atrace_categories: "video"

atrace_categories: "camera"

atrace_categories: "hal"

atrace_categories: "res"

atrace_categories: "dalvik"

atrace_categories: "rs"

atrace_categories: "bionic"

atrace_categories: "power"

atrace_categories: "pm"

atrace_categories: "ss"

atrace_categories: "database"

atrace_categories: "network"

atrace_categories: "adb"

atrace_categories:"vibrator"

atrace_categories: "aidl"

atrace_categories: "nnapi"

atrace_categories: "rro"

atrace_categories: "binder_driver"

atrace_categories: "binder_lock"

atrace_apps:"lmkd"

buffer_size_kb: 2048

drain_period_ms: 250

}

}

}

duration_ms: 10000

EOF

Perfetto log 解析