1#!/usr/bin/env python3 2# -*- coding: utf-8 -*- 3# 4# Copyright (c) 2024 Huawei Device Co., Ltd. 5# Licensed under the Apache License, Version 2.0 (the "License"); 6# you may not use this file except in compliance with the License. 7# You may obtain a copy of the License at 8# 9# http://www.apache.org/licenses/LICENSE-2.0 10# 11# Unless required by applicable law or agreed to in writing, software 12# distributed under the License is distributed on an "AS IS" BASIS, 13# WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. 14# See the License for the specific language governing permissions and 15# limitations under the License. 16# 17import re 18 19 20def parse_bytes_to_str(data): 21 decoded_str = "" 22 23 if data is None or data.strip() == "": 24 return decoded_str 25 26 if data.find(b'\x00') == -1: 27 decoded_str = data[:].decode('utf-8', errors="ignore") 28 return decoded_str 29 30 decoded_str = data[:data.index(b'\x00')].decode('utf-8', errors="ignore") 31 32 return decoded_str 33 34 35def parse_int_field(one_event, name, int_signed): 36 return int.from_bytes(one_event["fields"][name], byteorder='little', signed=int_signed) 37 38 39def parse(event_print_fmt, data, one_event): 40 result = None 41 parse_func = print_fmt_func_map.get(event_print_fmt, "") 42 if parse_func != "": 43 result = parse_func(data, one_event) 44 return result 45 46 47def parse_irq_handler_entry(data, one_event): 48 irq = parse_int_field(one_event, "irq", True) 49 data_pos = parse_int_field(one_event, "name", False) & 0xffff 50 51 return "irq=%d name=%s" % (irq, parse_bytes_to_str(data[data_pos:])) 52 53 54def parse_irq_handler_exit(data, one_event): 55 irq = parse_int_field(one_event, "irq", True) 56 ret = parse_int_field(one_event, "ret", True) 57 return "irq=%d ret=%s" % (irq, "handled" if ret else "unhandled") 58 59 60def parse_softirq_entry_exit(data, one_event): 61 vec = parse_int_field(one_event, "vec", False) 62 vec_map = {0: "HI", 1: "TIMER", 2: "NET_TX", 3: "NET_RX", 4: "BLOCK", 5: "IRQ_POLL", \ 63 6: "TASKLET", 7: "SCHED", 8: "HRTIMER", 9: "RCU"} 64 return "vec=%d [action=%s]" % (vec, vec_map.get(vec, '')) 65 66 67def parse_sched_wakeup_hm(data, one_event): 68 pname = parse_bytes_to_str(one_event["fields"]["pname[16]"]) 69 pid = parse_int_field(one_event, "pid", True) 70 prio = parse_int_field(one_event, "prio", True) 71 success = parse_int_field(one_event, "success", True) 72 target_cpu = parse_int_field(one_event, "target_cpu", True) 73 74 return "comm=%s pid=%d prio=%d target_cpu=%03d" % (pname, pid, prio, target_cpu) 75 76 77def parse_sched_wakeup(data, one_event): 78 comm = parse_bytes_to_str(one_event["fields"]["comm[16]"]) 79 pid = parse_int_field(one_event, "pid", True) 80 prio = parse_int_field(one_event, "prio", True) 81 success = parse_int_field(one_event, "success", True) 82 target_cpu = parse_int_field(one_event, "target_cpu", True) 83 84 return "comm=%s pid=%d prio=%d target_cpu=%03d" % (comm, pid, prio, target_cpu) 85 86 87def parse_sched_switch_hm_new(data, one_event): 88 pname = parse_bytes_to_str(one_event["fields"]["pname[16]"]) 89 prev_tid = parse_int_field(one_event, "prev_tid", True) 90 pprio = parse_int_field(one_event, "pprio", True) 91 pstate = parse_int_field(one_event, "pstate", True) 92 nname = parse_bytes_to_str(one_event["fields"]["nname[16]"]) 93 next_tid = parse_int_field(one_event, "next_tid", True) 94 nprio = parse_int_field(one_event, "nprio", True) 95 ninfo = one_event["fields"]["ninfo[8]"] 96 97 tmp_affinity = [hex(int.from_bytes(ninfo[value : value + 1], byteorder='big')) for value in range(len(ninfo))] 98 tmp_affinity = tmp_affinity[:4] 99 affinity = ''.join(value[2:] for value in tmp_affinity) 100 affinity = re.sub("0+", "", affinity) 101 102 load = (((ninfo[4] << 8) | ninfo[5]) >> 6) << 1 103 group = (ninfo[5] & 0b00110000) >> 4 104 restricted = (ninfo[5] & 0b00001000) >> 3 105 expel = ninfo[5] & 0b00000111 106 cgid = (ninfo[6] & 0b11111000) >> 3 107 next_info = affinity + ',' + str(load) + ',' + str(group) + ',' + str(restricted) + ',' + str(expel) + \ 108 ',' + str(cgid) 109 110 pstate_map = {0x0: 'R', 0x1: 'S', 0x2: 'D', 0x10: 'X', 0x100: 'R+'} 111 prev_state = pstate_map.get(pstate, '?') 112 113 return "prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s ==> next_comm=%s next_pid=%d next_prio=%d next_info=%s" \ 114 % (pname, prev_tid, pprio, prev_state, nname, next_tid, nprio, next_info) 115 116 117def parse_sched_switch_hm_ninfo_cg(data, one_event): 118 pname = parse_bytes_to_str(one_event["fields"]["pname[16]"]) 119 prev_tid = parse_int_field(one_event, "prev_tid", True) 120 pprio = parse_int_field(one_event, "pprio", True) 121 pstate = parse_int_field(one_event, "pstate", True) 122 nname = parse_bytes_to_str(one_event["fields"]["nname[16]"]) 123 next_tid = parse_int_field(one_event, "next_tid", True) 124 nprio = parse_int_field(one_event, "nprio", True) 125 ninfo = one_event["fields"]["ninfo[8]"] 126 cg = parse_bytes_to_str(one_event["fields"]["cg[32]"]) 127 128 tmp_affinity = [hex(int.from_bytes(ninfo[value : value + 1], byteorder='big')) for value in range(len(ninfo))] 129 tmp_affinity = tmp_affinity[:4] 130 affinity = ''.join(value[2:] for value in tmp_affinity) 131 affinity = re.sub("0+", "", affinity) 132 133 load = (((ninfo[4] << 8) | ninfo[5]) >> 6) << 1 134 group = (ninfo[5] & 0b00110000) >> 4 135 restricted = (ninfo[5] & 0b00001000) >> 3 136 expel = ninfo[5] & 0b00000111 137 next_info = affinity + ',' + str(load) + ',' + str(group) + ',' + str(restricted) + ',' + str(expel) 138 139 pstate_map = {0x0: 'R', 0x1: 'S', 0x2: 'D', 0x10: 'X', 0x100: 'R+'} 140 prev_state = pstate_map.get(pstate, '?') 141 142 return "prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s ==> next_comm=%s next_pid=%d next_prio=%d next_info=%s cg=%s" \ 143 % (pname, prev_tid, pprio, prev_state, nname, next_tid, nprio, next_info, cg) 144 145 146def parse_sched_switch_hm(data, one_event): 147 pname = parse_bytes_to_str(one_event["fields"]["pname[16]"]) 148 prev_tid = parse_int_field(one_event, "prev_tid", True) 149 pprio = parse_int_field(one_event, "pprio", True) 150 pstate = parse_int_field(one_event, "pstate", True) 151 nname = parse_bytes_to_str(one_event["fields"]["nname[16]"]) 152 next_tid = parse_int_field(one_event, "next_tid", True) 153 nprio = parse_int_field(one_event, "nprio", True) 154 155 pstate_map = {0x0: 'R', 0x1: 'S', 0x2: 'D', 0x10: 'X', 0x100: 'R+'} 156 prev_state = pstate_map.get(pstate, '?') 157 158 return "prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s ==> next_comm=%s next_pid=%d next_prio=%d" \ 159 % (pname, prev_tid, pprio, prev_state, nname, next_tid, nprio) 160 161 162def parse_sched_switch(data, one_event): 163 prev_comm = parse_bytes_to_str(one_event["fields"]["prev_comm[16]"]) 164 prev_pid = parse_int_field(one_event, "prev_pid", True) 165 prev_prio = parse_int_field(one_event, "prev_prio", True) 166 prev_state = parse_int_field(one_event, "prev_state", True) 167 next_comm = parse_bytes_to_str(one_event["fields"]["next_comm[16]"]) 168 next_pid = parse_int_field(one_event, "next_pid", True) 169 next_prio = parse_int_field(one_event, "next_prio", True) 170 expeller_type = parse_int_field(one_event, "expeller_type", False) 171 172 pstate_map = {0x1: 'S', 0x2: 'D', 0x4: 'T', 0x8: 't', 0x10: 'X', 0x20: 'Z', 0x40: 'P', 0x80: 'I'} 173 pstate = pstate_map.get(prev_state & 0xff, 'R') 174 if prev_state & 0x100 != 0: 175 pstate += '+' 176 177 return "prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s ==> next_comm=%s next_pid=%d next_prio=%d expeller_type=%d" \ 178 % (prev_comm, prev_pid, prev_prio, pstate, next_comm, next_pid, next_prio, expeller_type) 179 180 181def parse_sched_blocked_reason_hm_old(data, one_event): 182 pid = parse_int_field(one_event, "pid", True) 183 caller = parse_int_field(one_event, "caller", False) 184 iowait = parse_int_field(one_event, "iowait", False) 185 delay = parse_int_field(one_event, "delay", False) 186 cnode_idx = parse_int_field(one_event, "cnode_idx", False) 187 188 return "pid=%d iowait=%d caller=0x%x cnode_idx=%d delay=%d" % (pid, iowait, caller, cnode_idx, delay >> 10) 189 190 191def parse_sched_blocked_reason_hm(data, one_event): 192 pid = parse_int_field(one_event, "pid", True) 193 iowait = parse_int_field(one_event, "iowait", False) 194 func_name = parse_bytes_to_str(one_event["fields"]["func_name[20]"]) 195 offset = parse_int_field(one_event, "offset", False) 196 size = parse_int_field(one_event, "size", False) 197 mod_name = parse_bytes_to_str(one_event["fields"]["mod_name[12]"]) 198 delay = parse_int_field(one_event, "delay", False) 199 200 return "pid=%d iowait=%d caller=%s+0x%lx/0x%lx[%s] delay=%d" \ 201 % (pid, iowait, func_name, offset, size, mod_name, delay >> 10) 202 203 204def parse_sched_blocked_reason(data, one_event): 205 pid = parse_int_field(one_event, "pid", True) 206 caller = parse_int_field(one_event, "caller", False) 207 iowait = parse_int_field(one_event, "iowait", False) 208 delay = parse_int_field(one_event, "delay", False) 209 210 return "pid=%d iowait=%d caller=0x%x delay=%d" % (pid, iowait, caller, delay >> 10) 211 212 213def parse_cpu_frequency(data, one_event): 214 state = parse_int_field(one_event, "state", False) 215 cpu_id = parse_int_field(one_event, "cpu_id", False) 216 217 return "state=%d cpu_id=%d" % (state, cpu_id) 218 219 220def parse_clock_set_rate(data, one_event): 221 data_pos = parse_int_field(one_event, "name", False) & 0xffff 222 state = parse_int_field(one_event, "state", False) 223 cpu_id = parse_int_field(one_event, "cpu_id", False) 224 225 return "%s state=%d cpu_id=%d" % (parse_bytes_to_str(data[data_pos:]), state, cpu_id) 226 227 228def parse_cpu_frequency_limits_hm(data, one_event): 229 min_freq = parse_int_field(one_event, "min", False) 230 max_freq = parse_int_field(one_event, "max", False) 231 cpu_id = parse_int_field(one_event, "cpu_id", False) 232 233 return "min=%d max=%d cpu_id=%d" % (min_freq, max_freq, cpu_id) 234 235 236def parse_cpu_frequency_limits(data, one_event): 237 min_freq = parse_int_field(one_event, "min_freq", False) 238 max_freq = parse_int_field(one_event, "max_freq", False) 239 cpu_id = parse_int_field(one_event, "cpu_id", False) 240 241 return "min=%d max=%d cpu_id=%d" % (min_freq, max_freq, cpu_id) 242 243 244def parse_cpu_idle(data, one_event): 245 state = parse_int_field(one_event, "state", False) 246 cpu_id = parse_int_field(one_event, "cpu_id", False) 247 248 return "state=%d cpu_id=%d" % (state, cpu_id) 249 250 251def parse_ext4_da_write_begin(data, one_event): 252 dev = parse_int_field(one_event, "dev", False) 253 ino = parse_int_field(one_event, "ino", False) 254 pos = parse_int_field(one_event, "pos", True) 255 len_write = parse_int_field(one_event, "len", False) 256 flags = parse_int_field(one_event, "flags", False) 257 258 return "dev %d,%d ino %d pos %d len %d flags %d" \ 259 % (dev >> 20, dev & 0xfffff, ino, pos, len_write, flags) 260 261 262def parse_ext4_da_write_end(data, one_event): 263 dev = parse_int_field(one_event, "dev", False) 264 ino = parse_int_field(one_event, "ino", False) 265 pos = parse_int_field(one_event, "pos", True) 266 len_write = parse_int_field(one_event, "len", False) 267 copied = parse_int_field(one_event, "copied", False) 268 269 return "dev %d,%d ino %d pos %d len %d copied %d" \ 270 % (dev >> 20, dev & 0xfffff, ino, pos, len_write, copied) 271 272 273def parse_ext4_sync_file_enter(data, one_event): 274 dev = parse_int_field(one_event, "dev", False) 275 ino = parse_int_field(one_event, "ino", False) 276 parent = parse_int_field(one_event, "parent", False) 277 datasync = parse_int_field(one_event, "datasync", True) 278 279 return "dev %d,%d ino %d parent %d datasync %d " \ 280 % (dev >> 20, dev & 0xfffff, ino, parent, datasync) 281 282 283def parse_ext4_sync_file_exit(data, one_event): 284 dev = parse_int_field(one_event, "dev", False) 285 ino = parse_int_field(one_event, "ino", False) 286 ret = parse_int_field(one_event, "ret", True) 287 return "dev %d,%d ino %d ret %d" % (dev >> 20, dev & 0xfffff, ino, ret) 288 289 290def parse_block_bio_remap(data, one_event): 291 dev = parse_int_field(one_event, "dev", False) 292 sector = parse_int_field(one_event, "sector", False) 293 nr_sector = parse_int_field(one_event, "nr_sector", False) 294 old_dev = parse_int_field(one_event, "old_dev", False) 295 old_sector = parse_int_field(one_event, "old_sector", False) 296 rwbs = parse_bytes_to_str(one_event["fields"]["rwbs[8]"]) 297 298 return "%d,%d %s %d + %d <- (%d,%d) %d" \ 299 % (dev >> 20, dev & 0xfffff, rwbs, sector, nr_sector, old_dev >> 20, old_dev & 0xfffff, old_sector) 300 301 302def parse_block_bio_remap_new(data, one_event): 303 dev = parse_int_field(one_event, "dev", False) 304 sector = parse_int_field(one_event, "sector", False) 305 nr_sector = parse_int_field(one_event, "nr_sector", False) 306 old_dev = parse_int_field(one_event, "old_dev", False) 307 old_sector = parse_int_field(one_event, "old_sector", False) 308 309 return "%d,%d %d + %d <- (%d,%d) %d" \ 310 % (dev >> 20, dev & 0xfffff, sector, nr_sector, old_dev >> 20, old_dev & 0xfffff, old_sector) 311 312 313def parse_block_rq_issue_hm(data, one_event): 314 dev = parse_int_field(one_event, "dev", False) 315 sector = parse_int_field(one_event, "sector", False) 316 nr_sector = parse_int_field(one_event, "nr_sector", False) 317 bytes_num = parse_int_field(one_event, "bytes", False) 318 rwbs = parse_bytes_to_str(one_event["fields"]["rwbs[8]"]) 319 comm = parse_bytes_to_str(one_event["fields"]["comm[16]"]) 320 cmd = parse_bytes_to_str(one_event["fields"]["cmd[16]"]) 321 322 return "%d,%d %s %d (%s) %d + %d [%s]" \ 323 % (dev >> 20, dev & 0xfffff, rwbs, bytes_num, cmd, sector, nr_sector, comm) 324 325 326def parse_block_rq_issue_or_insert(data, one_event): 327 dev = parse_int_field(one_event, "dev", False) 328 sector = parse_int_field(one_event, "sector", False) 329 nr_sector = parse_int_field(one_event, "nr_sector", False) 330 bytes_num = parse_int_field(one_event, "bytes", False) 331 rwbs = parse_bytes_to_str(one_event["fields"]["rwbs[8]"]) 332 comm = parse_bytes_to_str(one_event["fields"]["comm[16]"]) 333 cmd_pos = parse_int_field(one_event, "cmd", False) & 0xffff 334 335 return "%d,%d %s %d (%s) %d + %d [%s]" \ 336 % (dev >> 20, dev & 0xfffff, rwbs, bytes_num, parse_bytes_to_str(data[cmd_pos:]), sector, nr_sector, comm) 337 338 339def parse_block_rq_complete_hm(data, one_event): 340 dev = parse_int_field(one_event, "dev", False) 341 sector = parse_int_field(one_event, "sector", False) 342 nr_sector = parse_int_field(one_event, "nr_sector", False) 343 error = parse_int_field(one_event, "error", True) 344 rwbs = parse_bytes_to_str(one_event["fields"]["rwbs[8]"]) 345 cmd = parse_bytes_to_str(one_event["fields"]["cmd[16]"]) 346 347 return "%d,%d %s (%s) %d + %d [%d]" \ 348 % (dev >> 20, dev & 0xfffff, rwbs, cmd, sector, nr_sector, error) 349 350 351def parse_block_rq_complete(data, one_event): 352 dev = parse_int_field(one_event, "dev", False) 353 sector = parse_int_field(one_event, "sector", False) 354 nr_sector = parse_int_field(one_event, "nr_sector", False) 355 error = parse_int_field(one_event, "error", True) 356 rwbs = parse_bytes_to_str(one_event["fields"]["rwbs[8]"]) 357 cmd_pos = parse_int_field(one_event, "cmd", False) & 0xffff 358 359 return "%d,%d %s (%s) %d + %d [%d]" \ 360 % (dev >> 20, dev & 0xfffff, rwbs, parse_bytes_to_str(data[cmd_pos:]), sector, nr_sector, error) 361 362 363def parse_ufshcd_command_hm(data, one_event): 364 dev_name = parse_bytes_to_str(one_event["fields"]["dev_name[16]"]) 365 command_str = parse_bytes_to_str(one_event["fields"]["str[16]"]) 366 tag = parse_int_field(one_event, "tag", False) 367 doorbell = parse_int_field(one_event, "doorbell", False) 368 transfer_len = parse_int_field(one_event, "transfer_len", True) 369 intr = parse_int_field(one_event, "intr", False) 370 lba = parse_int_field(one_event, "lba", False) 371 opcode = parse_int_field(one_event, "opcode", False) 372 373 return "%s: %s: tag: %d, DB: 0x%x, size: %d, IS: %d, LBA: %d, opcode: 0x%x" \ 374 % (command_str, dev_name, tag, doorbell, transfer_len, intr, lba, opcode) 375 376 377def parse_ufshcd_command(data, one_event): 378 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 379 str_pos = parse_int_field(one_event, "str", False) & 0xffff 380 tag = parse_int_field(one_event, "tag", False) 381 doorbell = parse_int_field(one_event, "doorbell", False) 382 transfer_len = parse_int_field(one_event, "transfer_len", True) 383 intr = parse_int_field(one_event, "intr", False) 384 lba = parse_int_field(one_event, "lba", False) 385 opcode = parse_int_field(one_event, "opcode", False) 386 group_id = parse_int_field(one_event, "group_id", False) 387 388 opcode_map = {0x8a: "WRITE_16", 0x2a: "WRITE_10", 0x88: "READ_16", \ 389 0x28: "READ_10", 0x35: "SYNC", 0x42: "UNMAP"} 390 391 return "%s: %s: tag: %d, DB: 0x%x, size: %d, IS: %d, LBA: %d, opcode: 0x%x (%s), group_id: 0x%x" \ 392 % (parse_bytes_to_str(data[str_pos:]), parse_bytes_to_str(data[dev_name_pos:]), tag, doorbell, \ 393 transfer_len, intr, lba, opcode, opcode_map.get(opcode, ""), group_id) 394 395 396def parse_ufshcd_upiu(data, one_event): 397 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 398 str_pos = parse_int_field(one_event, "str", False) & 0xffff 399 hdr = parse_int_field(one_event, "hdr[12]", False) 400 tsf = parse_int_field(one_event, "tsf[16]", False) 401 402 return "%s: %s: HDR:0x%x, CDB:0x%x" % (parse_bytes_to_str(data[str_pos:]), \ 403 parse_bytes_to_str(data[dev_name_pos:]), hdr, tsf) 404 405 406def parse_ufshcd_uic_command(data, one_event): 407 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 408 str_pos = parse_int_field(one_event, "str", False) & 0xffff 409 cmd = parse_int_field(one_event, "cmd", False) 410 arg1 = parse_int_field(one_event, "arg1", False) 411 arg2 = parse_int_field(one_event, "arg2", False) 412 arg3 = parse_int_field(one_event, "arg3", False) 413 414 return "%s: %s: cmd: 0x%x, arg1: 0x%x, arg2: 0x%x, arg3: 0x%x" \ 415 % (parse_bytes_to_str(data[str_pos:]), parse_bytes_to_str(data[dev_name_pos:]), cmd, arg1, arg2, arg3) 416 417 418def parse_ufshcd_funcs(data, one_event): 419 usecs = parse_int_field(one_event, "usecs", True) 420 err = parse_int_field(one_event, "err", True) 421 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 422 dev_state = parse_int_field(one_event, "dev_state", True) 423 link_state = parse_int_field(one_event, "link_state", True) 424 425 dev_state_map = {1: "UFS_ACTIVE_PWR_MODE", 2: "UFS_SLEEP_PWR_MODE", 3: "UFS_POWERDOWN_PWR_MODE"} 426 link_state_map = {0: "UIC_LINK_OFF_STATE", 1: "UIC_LINK_ACTIVE_STATE", 2: "UIC_LINK_HIBERN8_STATE"} 427 428 return "%s: took %d usecs, dev_state: %s, link_state: %s, err %d" \ 429 % (parse_bytes_to_str(data[dev_name_pos:]), usecs, dev_state_map.get(dev_state, ""), \ 430 link_state_map.get(link_state, ""), err) 431 432 433def parse_ufshcd_profile_funcs(data, one_event): 434 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 435 profile_info_pos = parse_int_field(one_event, "profile_info", False) & 0xffff 436 time_us = parse_int_field(one_event, "time_us", True) 437 err = parse_int_field(one_event, "err", True) 438 439 return "%s: %s: took %d usecs, err %d" \ 440 % (parse_bytes_to_str(data[dev_name_pos:]), parse_bytes_to_str(data[profile_info_pos:]), time_us, err) 441 442 443def parse_ufshcd_auto_bkops_state(data, one_event): 444 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 445 state_pos = parse_int_field(one_event, "state", False) & 0xffff 446 447 return "%s: auto bkops - %s" % (parse_bytes_to_str(data[dev_name_pos:]), parse_bytes_to_str(data[state_pos:])) 448 449 450def parse_ufshcd_clk_scaling(data, one_event): 451 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 452 state_pos = parse_int_field(one_event, "state", False) & 0xffff 453 clk_pos = parse_int_field(one_event, "clk", False) & 0xffff 454 prev_state = parse_int_field(one_event, "prev_state", False) 455 curr_state = parse_int_field(one_event, "curr_state", False) 456 457 return "%s: %s %s from %d to %d Hz" % (parse_bytes_to_str(data[dev_name_pos:]), \ 458 parse_bytes_to_str(data[state_pos:]), parse_bytes_to_str(data[clk_pos:]), prev_state, curr_state) 459 460 461def parse_ufshcd_clk_gating(data, one_event): 462 dev_name_pos = parse_int_field(one_event, "dev_name", False) & 0xffff 463 state = parse_int_field(one_event, "state", True) 464 465 state_map = {0: "CLKS_OFF", 1: "CLKS_ON", 2: "REQ_CLKS_OFF", 3: "REQ_CLKS_ON"} 466 467 return "%s: gating state changed to %s" % (parse_bytes_to_str(data[dev_name_pos:]), state_map.get(state, '')) 468 469 470def parse_i2c_read(data, one_event): 471 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 472 msg_nr = parse_int_field(one_event, "msg_nr", False) 473 addr = parse_int_field(one_event, "addr", False) 474 flags = parse_int_field(one_event, "flags", False) 475 len_read = parse_int_field(one_event, "len", False) 476 477 return "i2c-%d #%d a=%03x f=%04x l=%d" % (adapter_nr, msg_nr, addr, flags, len_read) 478 479 480def parse_i2c_write_or_reply(data, one_event): 481 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 482 msg_nr = parse_int_field(one_event, "msg_nr", False) 483 addr = parse_int_field(one_event, "addr", False) 484 flags = parse_int_field(one_event, "flags", False) 485 len_write = parse_int_field(one_event, "len", False) 486 buf_pos = parse_int_field(one_event, "buf", False) & 0xffff 487 buf_str = "" 488 read_cnt = 0 489 while read_cnt < len_write: 490 temp_data = parse_bytes_to_str(data[buf_pos + read_cnt : buf_pos + read_cnt + 1]) 491 if temp_data == "" or temp_data == '\x00': 492 buf_str += "00" 493 else: 494 buf_str += temp_data.encode('utf-8').hex() 495 if read_cnt < (len_write - 1): 496 buf_str += "-" 497 read_cnt += 1 498 buf_str += "]" 499 return ("i2c-%d #%d a=%03x f=%04x l=%d %s" % (adapter_nr, msg_nr, addr, flags, len_write, buf_str)) 500 501 502def parse_i2c_result(data, one_event): 503 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 504 nr_msgs = parse_int_field(one_event, "nr_msgs", False) 505 ret = parse_int_field(one_event, "ret", True) 506 507 return "i2c-%d n=%d ret=%d" % (adapter_nr, nr_msgs, ret) 508 509 510def parse_smbus_read(data, one_event): 511 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 512 flags = parse_int_field(one_event, "flags", False) 513 addr = parse_int_field(one_event, "addr", False) 514 command = parse_int_field(one_event, "command", False) 515 protocol = parse_int_field(one_event, "protocol", False) 516 517 protocol_map = {0: "QUICK", 1: "BYTE", 2: "BYTE_DATA", 3: "WORD_DATA", \ 518 4: "PROC_CALL", 5: "BLOCK_DATA", 6: "I2C_BLOCK_BROKEN", 7: "BLOCK_PROC_CALL", 8: "I2C_BLOCK_DATA"} 519 520 return "i2c-%d a=%03x f=%04x c=%x %s" % (adapter_nr, addr, flags, command, protocol_map.get(protocol, '')) 521 522 523def parse_smbus_write_or_reply(data, one_event): 524 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 525 addr = parse_int_field(one_event, "addr", False) 526 flags = parse_int_field(one_event, "flags", False) 527 command = parse_int_field(one_event, "command", False) 528 len_write = parse_int_field(one_event, "len", False) 529 protocol = parse_int_field(one_event, "protocol", False) 530 buf_key = "buf[32 + 2]" 531 buf_str = "" 532 if buf_key in one_event["fields"]: 533 buf_str = parse_bytes_to_str(one_event["fields"][buf_key]) 534 535 protocol_map = {0: "QUICK", 1: "BYTE", 2: "BYTE_DATA", 3: "WORD_DATA", \ 536 4: "PROC_CALL", 5: "BLOCK_DATA", 6: "I2C_BLOCK_BROKEN", 7: "BLOCK_PROC_CALL", 8: "I2C_BLOCK_DATA"} 537 538 return ("i2c-%d a=%03x f=%04x c=%x %s l=%d %s" \ 539 % (adapter_nr, addr, flags, command, protocol_map.get(protocol, ''), len_write, buf_str)) 540 541 542def parse_smbus_result(data, one_event): 543 adapter_nr = parse_int_field(one_event, "adapter_nr", True) 544 addr = parse_int_field(one_event, "addr", False) 545 flags = parse_int_field(one_event, "flags", False) 546 read_write_value = parse_int_field(one_event, "read_write", False) 547 command = parse_int_field(one_event, "command", False) 548 res = parse_int_field(one_event, "res", True) 549 protocol = parse_int_field(one_event, "protocol", False) 550 551 protocol_map = {0: "QUICK", 1: "BYTE", 2: "BYTE_DATA", 3: "WORD_DATA", \ 552 4: "PROC_CALL", 5: "BLOCK_DATA", 6: "I2C_BLOCK_BROKEN", 7: "BLOCK_PROC_CALL", 8: "I2C_BLOCK_DATA"} 553 read_write = "wr" if read_write_value == 0 else "rd" 554 555 return "i2c-%d a=%03x f=%04x c=%x %s %s res=%d" \ 556 % (adapter_nr, addr, flags, command, protocol_map.get(protocol, ''), read_write, res) 557 558 559def parse_regulator_set_voltage_complete(data, one_event): 560 name_pos = parse_int_field(one_event, "name", False) & 0xffff 561 val = parse_int_field(one_event, "val", False) 562 563 return "name=%s, val=%d" % (parse_bytes_to_str(data[name_pos:]), val) 564 565 566def parse_regulator_set_voltage(data, one_event): 567 name_pos = parse_int_field(one_event, "name", False) & 0xffff 568 min_voltage = parse_int_field(one_event, "min", True) 569 max_voltage = parse_int_field(one_event, "max", True) 570 571 return "name=%s (%d-%d)" % (parse_bytes_to_str(data[name_pos:]), min_voltage, max_voltage) 572 573 574def parse_regulator_funcs(data, one_event): 575 name_pos = parse_int_field(one_event, "name", False) & 0xffff 576 577 return "name=%s" % (parse_bytes_to_str(data[name_pos:])) 578 579 580def parse_dma_fence_funcs(data, one_event): 581 driver_pos = parse_int_field(one_event, "driver", False) & 0xffff 582 timeline_pos = parse_int_field(one_event, "timeline", False) & 0xffff 583 context = parse_int_field(one_event, "context", False) 584 seqno = parse_int_field(one_event, "seqno", False) 585 586 return "driver=%s timeline=%s context=%d seqno=%d" \ 587 % (parse_bytes_to_str(data[driver_pos:]), parse_bytes_to_str(data[timeline_pos:]), context, seqno) 588 589 590def parse_binder_transaction(data, one_event): 591 debug_id = parse_int_field(one_event, "debug_id", True) 592 target_node = parse_int_field(one_event, "target_node", True) 593 to_proc = parse_int_field(one_event, "to_proc", True) 594 to_thread = parse_int_field(one_event, "to_thread", True) 595 reply = parse_int_field(one_event, "reply", True) 596 code = parse_int_field(one_event, "code", False) 597 flags = parse_int_field(one_event, "flags", False) 598 599 return "transaction=%d dest_node=%d dest_proc=%d dest_thread=%d reply=%d flags=0x%x code=0x%x" \ 600 % (debug_id, target_node, to_proc, to_thread, reply, flags, code) 601 602 603def parse_binder_transaction_received(data, one_event): 604 debug_id = parse_int_field(one_event, "debug_id", True) 605 606 return "transaction=%d" % (debug_id) 607 608 609def parse_mmc_request_start(data, one_event): 610 cmd_opcode = parse_int_field(one_event, "cmd_opcode", False) 611 cmd_arg = parse_int_field(one_event, "cmd_arg", False) 612 cmd_flags = parse_int_field(one_event, "cmd_flags", False) 613 cmd_retries = parse_int_field(one_event, "cmd_retries", False) 614 stop_opcode = parse_int_field(one_event, "stop_opcode", False) 615 stop_arg = parse_int_field(one_event, "stop_arg", False) 616 stop_flags = parse_int_field(one_event, "stop_flags", False) 617 stop_retries = parse_int_field(one_event, "stop_retries", False) 618 sbc_opcode = parse_int_field(one_event, "sbc_opcode", False) 619 sbc_arg = parse_int_field(one_event, "sbc_arg", False) 620 sbc_flags = parse_int_field(one_event, "sbc_flags", False) 621 sbc_retries = parse_int_field(one_event, "sbc_retries", False) 622 blocks = parse_int_field(one_event, "blocks", False) 623 blk_addr = parse_int_field(one_event, "blk_addr", False) 624 blksz = parse_int_field(one_event, "blksz", False) 625 data_flags = parse_int_field(one_event, "data_flags", False) 626 tag = parse_int_field(one_event, "tag", True) 627 can_retune = parse_int_field(one_event, "can_retune", False) 628 doing_retune = parse_int_field(one_event, "doing_retune", False) 629 retune_now = parse_int_field(one_event, "retune_now", False) 630 need_retune = parse_int_field(one_event, "need_retune", False) 631 hold_retune = parse_int_field(one_event, "hold_retune", True) 632 retune_period = parse_int_field(one_event, "retune_period", True) 633 mrq = parse_int_field(one_event, "mrq", False) 634 name = parse_bytes_to_str(one_event["fields"]["name"]) 635 636 return "%s: start struct mmc_request[0x%x]: cmd_opcode=%d cmd_arg=0x%x cmd_flags=0x%x \ 637 cmd_retries=%d stop_opcode=%d stop_arg=0x%x stop_flags=0x%x stop_retries=%d sbc_opcode=%d \ 638 sbc_arg=0x%x sbc_flags=0x%x sbc_retires=%d blocks=%d block_size=%d blk_addr=%d data_flags=0x%x \ 639 tag=%d can_retune=%d doing_retune=%d retune_now=%d need_retune=%d hold_retune=%d retune_period=%d" \ 640 % (name, mrq, cmd_opcode, cmd_arg, cmd_flags, cmd_retries, stop_opcode, stop_arg, stop_flags, \ 641 stop_retries, sbc_opcode, sbc_arg, sbc_flags, sbc_retries, blocks, blksz, blk_addr, data_flags, \ 642 tag, can_retune, doing_retune, retune_now, need_retune, hold_retune, retune_period) 643 644 645def parse_mmc_request_done(data, one_event): 646 cmd_opcode = parse_int_field(one_event, "cmd_opcode", False) 647 cmd_err = parse_int_field(one_event, "cmd_err", True) 648 cmd_resp = list(one_event["fields"]["cmd_resp[4]"]) 649 cmd_retries = parse_int_field(one_event, "cmd_retries", False) 650 stop_opcode = parse_int_field(one_event, "stop_opcode", False) 651 stop_err = parse_int_field(one_event, "stop_err", True) 652 stop_resp = list(one_event["fields"]["stop_resp[4]"]) 653 stop_retries = parse_int_field(one_event, "stop_retries", False) 654 sbc_opcode = parse_int_field(one_event, "sbc_opcode", False) 655 sbc_err = parse_int_field(one_event, "sbc_err", True) 656 sbc_resp = list(one_event["fields"]["sbc_resp[4]"]) 657 sbc_retries = parse_int_field(one_event, "sbc_retries", False) 658 bytes_xfered = parse_int_field(one_event, "bytes_xfered", False) 659 data_err = parse_int_field(one_event, "data_err", True) 660 tag = parse_int_field(one_event, "tag", True) 661 can_retune = parse_int_field(one_event, "can_retune", False) 662 doing_retune = parse_int_field(one_event, "doing_retune", False) 663 retune_now = parse_int_field(one_event, "retune_now", False) 664 need_retune = parse_int_field(one_event, "need_retune", True) 665 hold_retune = parse_int_field(one_event, "hold_retune", True) 666 retune_period = parse_int_field(one_event, "retune_period", False) 667 mrq = parse_int_field(one_event, "mrq", False) 668 name = parse_bytes_to_str(one_event["fields"]["name"]) 669 670 return "%s: end struct mmc_request[0x%x]: cmd_opcode=%d cmd_err=%d cmd_resp=0x%x 0x%x 0x%x 0x%x \ 671 cmd_retries=%d stop_opcode=%d stop_err=%d stop_resp=0x%x 0x%x 0x%x 0x%x stop_retries=%d sbc_opcode=%d \ 672 sbc_err=%d sbc_resp=0x%x 0x%x 0x%x 0x%x sbc_retries=%d bytes_xfered=%d data_err=%d tag=%d can_retune=%d \ 673 doing_retune=%d retune_now=%d need_retune=%d hold_retune=%d retune_period=%d" \ 674 % (name, mrq, cmd_opcode, cmd_err, cmd_resp[0], cmd_resp[1], cmd_resp[2], cmd_resp[3], cmd_retries, \ 675 stop_opcode, stop_err, stop_resp[0], stop_resp[1], stop_resp[2], stop_resp[3], stop_retries, sbc_opcode, \ 676 sbc_err, sbc_resp[0], sbc_resp[1], sbc_resp[2], sbc_resp[3], sbc_retries, bytes_xfered, data_err, tag, \ 677 can_retune, doing_retune, retune_now, need_retune, hold_retune, retune_period) 678 679 680def parse_file_check_and_advance_wb_err(data, one_event): 681 file = parse_int_field(one_event, "file", False) 682 i_ino = parse_int_field(one_event, "i_ino", False) 683 s_dev = parse_int_field(one_event, "s_dev", False) 684 old = parse_int_field(one_event, "old", False) 685 new = parse_int_field(one_event, "new", False) 686 687 return "file=0x%x dev=%d:%d ino=0x%x old=0x%x new=0x%x" \ 688 % (file, s_dev >> 20, s_dev & 0xfffff, i_ino, old, new) 689 690 691def parse_filemap_set_wb_err(data, one_event): 692 i_ino = parse_int_field(one_event, "i_ino", False) 693 s_dev = parse_int_field(one_event, "s_dev", False) 694 errseq = parse_int_field(one_event, "errseq", False) 695 696 return "dev=%d:%d ino=0x%x errseq=0x%x" \ 697 % (s_dev >> 20, s_dev & 0xfffff, i_ino, errseq) 698 699 700def parse_mm_filemap_add_or_delete_page_cache(data, one_event): 701 pfn = parse_int_field(one_event, "pfn", False) 702 i_ino = parse_int_field(one_event, "i_ino", False) 703 index = parse_int_field(one_event, "index", False) 704 s_dev = parse_int_field(one_event, "s_dev", False) 705 pg = parse_int_field(one_event, "pg", False) 706 707 return "dev %d:%d ino 0x%x page=0x%x pfn=%d ofs=%d" \ 708 % (s_dev >> 20, s_dev & 0xfffff, i_ino, pg, pfn, index << 12) 709 710 711def parse_mm_filemap_add_or_delete_page_cache_new(data, one_event): 712 pfn = parse_int_field(one_event, "pfn", False) 713 i_ino = parse_int_field(one_event, "i_ino", False) 714 index = parse_int_field(one_event, "index", False) 715 s_dev = parse_int_field(one_event, "s_dev", False) 716 pg = parse_int_field(one_event, "pg", False) 717 718 return "dev %d:%d ino 0x%x page=0x%x pfn=%d ofs=%d" \ 719 % (s_dev >> 20, s_dev & 0xfffff, i_ino, pg, pfn, index << 12) 720 721 722def parse_rss_stat(data, one_event): 723 mm_id = parse_int_field(one_event, "mm_id", False) 724 curr = parse_int_field(one_event, "curr", False) 725 member = parse_int_field(one_event, "member", True) 726 size = parse_int_field(one_event, "size", True) 727 728 return "mm_id=%d curr=%d member=%d size=%d" % (mm_id, curr, member, size) 729 730 731def parse_workqueue_execute_start_or_end(data, one_event): 732 work = parse_int_field(one_event, "work", False) 733 function = parse_int_field(one_event, "function", False) 734 735 return "work struct 0x%x: function 0x%x" % (work, function) 736 737 738def parse_thermal_power_allocator(data, one_event): 739 tz_id = parse_int_field(one_event, "tz_id", True) 740 req_power_pos = parse_int_field(one_event, "req_power", False) & 0xffff 741 total_req_power = parse_int_field(one_event, "total_req_power", False) 742 granted_power_pos = parse_int_field(one_event, "granted_power", False) & 0xffff 743 total_granted_power = parse_int_field(one_event, "total_granted_power", False) 744 num_actors = parse_int_field(one_event, "num_actors", False) 745 power_range = parse_int_field(one_event, "power_range", False) 746 max_allocatable_power = parse_int_field(one_event, "max_allocatable_power", False) 747 current_temp = parse_int_field(one_event, "current_temp", True) 748 delta_temp = parse_int_field(one_event, "delta_temp", True) 749 750 req_power = "{" + ", ".join(str(x) for x in list(data[req_power_pos:req_power_pos + num_actors * 4])) + "}" 751 granted_power = "{" + \ 752 ", ".join(str(x) for x in list(data[granted_power_pos:granted_power_pos + num_actors * 4])) + "}" 753 754 return "thermal_zone_id=%d req_power=%s total_req_power=%d granted_power=%s total_granted_power=%d \ 755 power_range=%d max_allocatable_power=%d current_temperature=%d delta_temperature=%d" \ 756 % (tz_id, req_power, total_req_power, granted_power, total_granted_power, power_range, \ 757 max_allocatable_power, current_temp, delta_temp) 758 759 760def parse_thermal_power_allocator_pid(data, one_event): 761 tz_id = parse_int_field(one_event, "tz_id", True) 762 err = parse_int_field(one_event, "err", True) 763 err_integral = parse_int_field(one_event, "err_integral", True) 764 p = parse_int_field(one_event, "p", True) 765 i = parse_int_field(one_event, "i", True) 766 d = parse_int_field(one_event, "d", True) 767 output = parse_int_field(one_event, "output", True) 768 769 return "thermal_zone_id=%d err=%d err_integral=%d p=%d i=%d d=%d output=%d" \ 770 % (tz_id, err, err_integral, p, i, d, output) 771 772 773def parse_print(data, one_event): 774 ip = parse_int_field(one_event, "ip", False) 775 buf_pos = 16 776 777 return "0x%x: %s" % (ip, parse_bytes_to_str(data[buf_pos:])) 778 779 780def parse_tracing_mark_write(data, one_event): 781 data_pos = parse_int_field(one_event, "buffer", False) & 0xffff 782 result_str = parse_bytes_to_str(data[data_pos:]) 783 if result_str is None: 784 return "" 785 786 if result_str is not None: 787 if result_str.startswith("E|") and result_str[-1] == "|": 788 result_str = result_str[:-1] 789 elif result_str.startswith("S|") or result_str.startswith("F|") or result_str.startswith("C|"): 790 pos = result_str.rfind(' ') 791 if pos != -1: 792 result_str = result_str[:pos + 1] + "|" + result_str[pos + 1:] 793 return result_str 794 795 796def parse_xacct_tracing_mark_write(data, one_event): 797 start = parse_int_field(one_event, "start", False) 798 pid = parse_int_field(one_event, "pid", False) 799 if start == 1: 800 trace_type = "B" 801 name = parse_bytes_to_str(one_event["fields"]["name[64]"]) 802 else: 803 trace_type = "E" 804 name = "" 805 return "%c|%d|%s" % (trace_type, pid, name) 806 807 808PRINT_FMT_IRQ_HANDLER_ENTRY = '"irq=%d name=%s", REC->irq, ((char *)((void *)((char *)REC + (REC->__data_loc_name & 0xffff))))' 809PRINT_FMT_IRQ_HANDLER_EXIT = '"irq=%d ret=%s", REC->irq, REC->ret ? "handled" : "unhandled"' 810PRINT_FMT_SOFTIRQ_ENTRY_EXIT = '"vec=%u [action=%s]", REC->vec, __print_symbolic(REC->vec, { 0, "HI" }, { 1, "TIMER" }, { 2, "NET_TX" }, { 3, "NET_RX" }, { 4, "BLOCK" }, { 5, "IRQ_POLL" }, { 6, "TASKLET" }, { 7, "SCHED" }, { 8, "HRTIMER" }, { 9, "RCU" })' 811PRINT_FMT_SCHED_WAKEUP_HM = '"comm=%s pid=%d prio=%d target_cpu=%03d", REC->pname, REC->pid, REC->prio, REC->target_cpu' 812PRINT_FMT_SCHED_WAKEUP = '"comm=%s pid=%d prio=%d target_cpu=%03d", REC->comm, REC->pid, REC->prio, REC->target_cpu' 813PRINT_FMT_SCHED_SWITCH_HM = '"prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s" " ==> next_comm=%s next_pid=%d next_prio=%d", REC->pname, REC->prev_tid, REC->pprio, hm_trace_tcb_state2str(REC->pstate), REC->nname, REC->next_tid, REC->nprio' 814PRINT_FMT_SCHED_SWITCH_HM_NEW = '"prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s" " ==> next_comm=%s next_pid=%d next_prio=%d next_info=%s", REC->pname, REC->prev_tid, REC->pprio, hm_trace_tcb_state2str(REC->pstate), REC->nname, REC->next_tid, REC->nprio, hm_trace_tcb_unpack_schedinfo(REC->ninfo, sizeof(REC->ninfo))' 815PRINT_FMT_SCHED_SWITCH_HM_NINFO_CG = '"prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s" " ==> next_comm=%s next_pid=%d next_prio=%d next_info=%s cg=%s", REC->pname, REC->prev_tid, REC->pprio, hm_trace_tcb_state2str(REC->pstate), REC->nname, REC->next_tid, REC->nprio, hm_trace_tcb_unpack_schedinfo(REC->ninfo, sizeof(REC->ninfo)), REC->cg' 816PRINT_FMT_SCHED_SWITCH = '"prev_comm=%s prev_pid=%d prev_prio=%d prev_state=%s%s ==> next_comm=%s next_pid=%d next_prio=%d expeller_type=%u", REC->prev_comm, REC->prev_pid, REC->prev_prio, (REC->prev_state & ((((0x0000 | 0x0001 | 0x0002 | 0x0004 | 0x0008 | 0x0010 | 0x0020 | 0x0040) + 1) << 1) - 1)) ? __print_flags(REC->prev_state & ((((0x0000 | 0x0001 | 0x0002 | 0x0004 | 0x0008 | 0x0010 | 0x0020 | 0x0040) + 1) << 1) - 1), "|", { 0x0001, "S" }, { 0x0002, "D" }, { 0x0004, "T" }, { 0x0008, "t" }, { 0x0010, "X" }, { 0x0020, "Z" }, { 0x0040, "P" }, { 0x0080, "I" }) : "R", REC->prev_state & (((0x0000 | 0x0001 | 0x0002 | 0x0004 | 0x0008 | 0x0010 | 0x0020 | 0x0040) + 1) << 1) ? "+" : "", REC->next_comm, REC->next_pid, REC->next_prio, REC->expeller_type' 817PRINT_FMT_SCHED_BLOCKED_REASON_HM_OLD = '"pid=%d iowait=%d caller=%s delay=%llu", REC->pid, REC->iowait, hm_trace_sched_blocked_reason_of(REC->cnode_idx, REC->caller), REC->delay >> 10' 818PRINT_FMT_SCHED_BLOCKED_REASON_HM = '"pid=%d iowait=%d caller=%s+0x%lx/0x%lx[%s] delay=%llu", REC->pid, REC->iowait, REC->func_name, REC->offset, REC->size, REC->mod_name, REC->delay >> 10' 819PRINT_FMT_SCHED_BLOCKED_REASON = '"pid=%d iowait=%d caller=%pS delay=%lu", REC->pid, REC->io_wait, REC->caller, REC->delay>>10' 820PRINT_FMT_CPU_FREQUENCY_HM = '"state=%u cpu_id=%u", REC->state, REC->cpu_id' 821PRINT_FMT_CPU_FREQUENCY = '"state=%lu cpu_id=%lu", (unsigned long)REC->state, (unsigned long)REC->cpu_id' 822PRINT_FMT_CLOCK_SET_RATE_HM = '"%s state=%lu cpu_id=%lu", ((char *)((void *)((char *)REC + (REC->__data_loc_name & 0xffff)))), (unsigned long)REC->state, (unsigned long)REC->cpu_id' 823PRINT_FMT_CLOCK_SET_RATE = '"%s state=%lu cpu_id=%lu", __get_str(name), (unsigned long)REC->state, (unsigned long)REC->cpu_id' 824PRINT_FMT_CPU_FREQUENCY_LIMITS_HM = '"min=%lu max=%lu cpu_id=%lu", (unsigned long)REC->min, (unsigned long)REC->max, (unsigned long)REC->cpu_id' 825PRINT_FMT_CPU_FREQUENCY_LIMITS = '"min=%lu max=%lu cpu_id=%lu", (unsigned long)REC->min_freq, (unsigned long)REC->max_freq, (unsigned long)REC->cpu_id' 826PRINT_FMT_CPU_IDLE_HM = '"state=%u cpu_id=%u", REC->state, REC->cpu_id' 827PRINT_FMT_CPU_IDLE = '"state=%lu cpu_id=%lu", (unsigned long)REC->state, (unsigned long)REC->cpu_id' 828PRINT_FMT_EXT4_DA_WRITE_BEGIN = '"dev %d,%d ino %lu pos %lld len %u flags %u", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), (unsigned long) REC->ino, REC->pos, REC->len, REC->flags' 829PRINT_FMT_EXT4_DA_WRITE_END = '"dev %d,%d ino %lu pos %lld len %u copied %u", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), (unsigned long) REC->ino, REC->pos, REC->len, REC->copied' 830PRINT_FMT_EXT4_SYNC_FILE_ENTER = '"dev %d,%d ino %lu parent %lu datasync %d ", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), (unsigned long) REC->ino, (unsigned long) REC->parent, REC->datasync' 831PRINT_FMT_EXT4_SYNC_FILE_EXIT = '"dev %d,%d ino %lu ret %d", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), (unsigned long) REC->ino, REC->ret' 832PRINT_FMT_BLOCK_BIO_REMAP = '"%d,%d %s %llu + %u <- (%d,%d) %llu", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), REC->rwbs, (unsigned long long)REC->sector, REC->nr_sector, ((unsigned int) ((REC->old_dev) >> 20)), ((unsigned int) ((REC->old_dev) & ((1U << 20) - 1))), (unsigned long long)REC->old_sector' 833PRINT_FMT_BLOCK_BIO_REMAP_NEW = '"%d,%d %llu + %u <- (%d,%d) %llu", ((unsigned int) ((REC->dev) >> 20U)), ((unsigned int) ((REC->dev) & ((1U << 20U) - 1U))), (unsigned long long)REC->sector, REC->nr_sector, ((unsigned int) ((REC->old_dev) >> 20U)), ((unsigned int) ((REC->old_dev) & ((1U << 20U) - 1U))), (unsigned long long)REC->old_sector' 834PRINT_FMT_BLOCK_RQ_ISSUE_HM = '"%d,%d %s %u (%s) %llu + %u [%s]", ((unsigned int) ((REC->dev) >> 20U)), ((unsigned int) ((REC->dev) & ((1U << 20U) - 1U))), REC->rwbs, REC->bytes, REC->cmd, (unsigned long long)REC->sector, REC->nr_sector, REC->comm' 835PRINT_FMT_BLOCK_RQ_ISSUE_OR_INSERT = '"%d,%d %s %u (%s) %llu + %u [%s]", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), REC->rwbs, REC->bytes, __get_str(cmd), (unsigned long long)REC->sector, REC->nr_sector, REC->comm' 836PRINT_FMT_BLOCK_RQ_COMPLETE_HM = '"%d,%d %s (%s) %llu + %u [%d]", ((unsigned int) ((REC->dev) >> 20U)), ((unsigned int) ((REC->dev) & ((1U << 20U) - 1U))), REC->rwbs, REC->cmd, (unsigned long long)REC->sector, REC->nr_sector, REC->error' 837PRINT_FMT_BLOCK_RQ_COMPLETE = '"%d,%d %s (%s) %llu + %u [%d]", ((unsigned int) ((REC->dev) >> 20)), ((unsigned int) ((REC->dev) & ((1U << 20) - 1))), REC->rwbs, __get_str(cmd), (unsigned long long)REC->sector, REC->nr_sector, REC->error' 838PRINT_FMT_UFSHCD_COMMAND_HM = '"%s: %s: tag: %u, DB: 0x%x, size: %d, IS: %u, LBA: %llu, opcode: 0x%x", REC->str, REC->dev_name, REC->tag, REC->doorbell, REC->transfer_len, REC->intr, REC->lba, (uint32_t)REC->opcode' 839PRINT_FMT_UFSHCD_COMMAND = '"%s: %s: tag: %u, DB: 0x%x, size: %d, IS: %u, LBA: %llu, opcode: 0x%x (%s), group_id: 0x%x", __get_str(str), __get_str(dev_name), REC->tag, REC->doorbell, REC->transfer_len, REC->intr, REC->lba, (u32)REC->opcode, __print_symbolic(REC->opcode, { 0x8a, "WRITE_16" }, { 0x2a, "WRITE_10" }, { 0x88, "READ_16" }, { 0x28, "READ_10" }, { 0x35, "SYNC" }, { 0x42, "UNMAP" }), (u32)REC->group_id' 840PRINT_FMT_UFSHCD_UPIU = '"%s: %s: HDR:%s, CDB:%s", __get_str(str), __get_str(dev_name), __print_hex(REC->hdr, sizeof(REC->hdr)), __print_hex(REC->tsf, sizeof(REC->tsf))' 841PRINT_FMT_UFSHCD_UIC_COMMAND = '"%s: %s: cmd: 0x%x, arg1: 0x%x, arg2: 0x%x, arg3: 0x%x", __get_str(str), __get_str(dev_name), REC->cmd, REC->arg1, REC->arg2, REC->arg3' 842PRINT_FMT_UFSHCD_FUNCS = '"%s: took %lld usecs, dev_state: %s, link_state: %s, err %d", __get_str(dev_name), REC->usecs, __print_symbolic(REC->dev_state, { 1, "UFS_ACTIVE_PWR_MODE" }, { 2, "UFS_SLEEP_PWR_MODE" }, { 3, "UFS_POWERDOWN_PWR_MODE" }), __print_symbolic(REC->link_state, { 0, "UIC_LINK_OFF_STATE" }, { 1, "UIC_LINK_ACTIVE_STATE" }, { 2, "UIC_LINK_HIBERN8_STATE" }), REC->err' 843PRINT_FMT_UFSHCD_PROFILE_FUNCS = '"%s: %s: took %lld usecs, err %d", __get_str(dev_name), __get_str(profile_info), REC->time_us, REC->err' 844PRINT_FMT_UFSHCD_AUTO_BKOPS_STATE = '"%s: auto bkops - %s", __get_str(dev_name), __get_str(state)' 845PRINT_FMT_UFSHCD_CLK_SCALING = '"%s: %s %s from %u to %u Hz", __get_str(dev_name), __get_str(state), __get_str(clk), REC->prev_state, REC->curr_state' 846PRINT_FMT_UFSHCD_CLK_GATING = '"%s: gating state changed to %s", __get_str(dev_name), __print_symbolic(REC->state, { 0, "CLKS_OFF" }, { 1, "CLKS_ON" }, { 2, "REQ_CLKS_OFF" }, { 3, "REQ_CLKS_ON" })' 847PRINT_FMT_I2C_READ = '"i2c-%d #%u a=%03x f=%04x l=%u", REC->adapter_nr, REC->msg_nr, REC->addr, REC->flags, REC->len' 848PRINT_FMT_I2C_WRITE_OR_REPLY = '"i2c-%d #%u a=%03x f=%04x l=%u [%*phD]", REC->adapter_nr, REC->msg_nr, REC->addr, REC->flags, REC->len, REC->len, __get_dynamic_array(buf)' 849PRINT_FMT_I2C_RESULT = '"i2c-%d n=%u ret=%d", REC->adapter_nr, REC->nr_msgs, REC->ret' 850PRINT_FMT_SMBUS_READ = '"i2c-%d a=%03x f=%04x c=%x %s", REC->adapter_nr, REC->addr, REC->flags, REC->command, __print_symbolic(REC->protocol, { 0, "QUICK" }, { 1, "BYTE" }, { 2, "BYTE_DATA" }, { 3, "WORD_DATA" }, { 4, "PROC_CALL" }, { 5, "BLOCK_DATA" }, { 6, "I2C_BLOCK_BROKEN" }, { 7, "BLOCK_PROC_CALL" }, { 8, "I2C_BLOCK_DATA" })' 851PRINT_FMT_SMBUS_WRITE_OR_REPLY = '"i2c-%d a=%03x f=%04x c=%x %s l=%u [%*phD]", REC->adapter_nr, REC->addr, REC->flags, REC->command, __print_symbolic(REC->protocol, { 0, "QUICK" }, { 1, "BYTE" }, { 2, "BYTE_DATA" }, { 3, "WORD_DATA" }, { 4, "PROC_CALL" }, { 5, "BLOCK_DATA" }, { 6, "I2C_BLOCK_BROKEN" }, { 7, "BLOCK_PROC_CALL" }, { 8, "I2C_BLOCK_DATA" }), REC->len, REC->len, REC->buf' 852PRINT_FMT_SMBUS_RESULT = '"i2c-%d a=%03x f=%04x c=%x %s %s res=%d", REC->adapter_nr, REC->addr, REC->flags, REC->command, __print_symbolic(REC->protocol, { 0, "QUICK" }, { 1, "BYTE" }, { 2, "BYTE_DATA" }, { 3, "WORD_DATA" }, { 4, "PROC_CALL" }, { 5, "BLOCK_DATA" }, { 6, "I2C_BLOCK_BROKEN" }, { 7, "BLOCK_PROC_CALL" }, { 8, "I2C_BLOCK_DATA" }), REC->read_write == 0 ? "wr" : "rd", REC->res' 853PRINT_FMT_REGULATOR_SET_VOLTAGE_COMPLETE = '"name=%s, val=%u", __get_str(name), (int)REC->val' 854PRINT_FMT_REGULATOR_SET_VOLTAGE = '"name=%s (%d-%d)", __get_str(name), (int)REC->min, (int)REC->max' 855PRINT_FMT_REGULATOR_FUNCS = '"name=%s", __get_str(name)' 856PRINT_FMT_DMA_FENCE_FUNCS = '"driver=%s timeline=%s context=%u seqno=%u", __get_str(driver), __get_str(timeline), REC->context, REC->seqno' 857PRINT_FMT_BINDER_TRANSACTION = '"transaction=%d dest_node=%d dest_proc=%d dest_thread=%d reply=%d flags=0x%x code=0x%x", REC->debug_id, REC->target_node, REC->to_proc, REC->to_thread, REC->reply, REC->flags, REC->code' 858PRINT_FMT_BINDER_TRANSACTION_RECEIVED = '"transaction=%d", REC->debug_id' 859PRINT_FMT_MMC_REQUEST_START = '"%s: start struct mmc_request[%p]: cmd_opcode=%u cmd_arg=0x%x cmd_flags=0x%x cmd_retries=%u stop_opcode=%u stop_arg=0x%x stop_flags=0x%x stop_retries=%u sbc_opcode=%u sbc_arg=0x%x sbc_flags=0x%x sbc_retires=%u blocks=%u block_size=%u blk_addr=%u data_flags=0x%x tag=%d can_retune=%u doing_retune=%u retune_now=%u need_retune=%d hold_retune=%d retune_period=%u", __get_str(name), REC->mrq, REC->cmd_opcode, REC->cmd_arg, REC->cmd_flags, REC->cmd_retries, REC->stop_opcode, REC->stop_arg, REC->stop_flags, REC->stop_retries, REC->sbc_opcode, REC->sbc_arg, REC->sbc_flags, REC->sbc_retries, REC->blocks, REC->blksz, REC->blk_addr, REC->data_flags, REC->tag, REC->can_retune, REC->doing_retune, REC->retune_now, REC->need_retune, REC->hold_retune, REC->retune_period' 860PRINT_FMT_MMC_REQUEST_DONE = '"%s: end struct mmc_request[%p]: cmd_opcode=%u cmd_err=%d cmd_resp=0x%x 0x%x 0x%x 0x%x cmd_retries=%u stop_opcode=%u stop_err=%d stop_resp=0x%x 0x%x 0x%x 0x%x stop_retries=%u sbc_opcode=%u sbc_err=%d sbc_resp=0x%x 0x%x 0x%x 0x%x sbc_retries=%u bytes_xfered=%u data_err=%d tag=%d can_retune=%u doing_retune=%u retune_now=%u need_retune=%d hold_retune=%d retune_period=%u", __get_str(name), REC->mrq, REC->cmd_opcode, REC->cmd_err, REC->cmd_resp[0], REC->cmd_resp[1], REC->cmd_resp[2], REC->cmd_resp[3], REC->cmd_retries, REC->stop_opcode, REC->stop_err, REC->stop_resp[0], REC->stop_resp[1], REC->stop_resp[2], REC->stop_resp[3], REC->stop_retries, REC->sbc_opcode, REC->sbc_err, REC->sbc_resp[0], REC->sbc_resp[1], REC->sbc_resp[2], REC->sbc_resp[3], REC->sbc_retries, REC->bytes_xfered, REC->data_err, REC->tag, REC->can_retune, REC->doing_retune, REC->retune_now, REC->need_retune, REC->hold_retune, REC->retune_period' 861PRINT_FMT_FILE_CHECK_AND_ADVANCE_WB_ERR = '"file=%p dev=%d:%d ino=0x%lx old=0x%x new=0x%x", REC->file, ((unsigned int)((REC->s_dev) >> 20)), ((unsigned int)((REC->s_dev) & ((1U << 20) - 1))), REC->i_ino, REC->old, REC->new' 862PRINT_FMT_FILEMAP_SET_WB_ERR = '"dev=%d:%d ino=0x%lx errseq=0x%x", ((unsigned int)((REC->s_dev) >> 20)), ((unsigned int)((REC->s_dev) & ((1U << 20) - 1))), REC->i_ino, REC->errseq' 863PRINT_FMT_MM_FILEMAP_ADD_OR_DELETE_PAGE_CACHE = '"dev %d:%d ino %lx page=%px pfn=%lu ofs=%lu", ((unsigned int)((REC->s_dev) >> 20)), ((unsigned int)((REC->s_dev) & ((1U << 20) - 1))), REC->i_ino, REC->pg, REC->pfn, REC->index << 12' 864PRINT_FMT_MM_FILEMAP_ADD_OR_DELETE_PAGE_CACHE_NEW = '"dev %d:%d ino %lx page=%p pfn=%lu ofs=%lu", ((unsigned int)((REC->s_dev) >> 20)), ((unsigned int)((REC->s_dev) & ((1U << 20) - 1))), REC->i_ino, REC->pg, REC->pfn, REC->index << 12' 865PRINT_FMT_RSS_STAT_HM = '"mm_id=%u curr=%d member=%d size=%ldB", REC->mm_id, REC->curr, REC->member, REC->size' 866PRINT_FMT_WORKQUEUE_EXECUTE_START_OR_END = '"work struct %p: function %ps", REC->work, REC->function' 867PRINT_FMT_THERMAL_POWER_ALLOCATOR_PID = '"thermal_zone_id=%d err=%d err_integral=%d p=%lld i=%lld d=%lld output=%d", REC->tz_id, REC->err, REC->err_integral, REC->p, REC->i, REC->d, REC->output' 868PRINT_FMT_THERMAL_POWER_ALLOCATOR = '"thermal_zone_id=%d req_power={%s} total_req_power=%u granted_power={%s} total_granted_power=%u power_range=%u max_allocatable_power=%u current_temperature=%d delta_temperature=%d", REC->tz_id, __print_array(__get_dynamic_array(req_power), REC->num_actors, 4), REC->total_req_power, __print_array(__get_dynamic_array(granted_power), REC->num_actors, 4), REC->total_granted_power, REC->power_range, REC->max_allocatable_power, REC->current_temp, REC->delta_temp' 869PRINT_FMT_PRINT = '"%ps: %s", (void *)REC->ip, REC->buf' 870PRINT_FMT_TRACING_MARK_WRITE = '"%s", ((void *)((char *)REC + (REC->__data_loc_buffer & 0xffff)))' 871PRINT_FMT_XACCT_TRACING_MARK_WRITE = '"%c|%d|%s", "EB"[REC->start], REC->pid, REC->start ? REC->name : ""' 872 873print_fmt_func_map = { 874PRINT_FMT_IRQ_HANDLER_ENTRY: parse_irq_handler_entry, 875PRINT_FMT_IRQ_HANDLER_EXIT: parse_irq_handler_exit, 876PRINT_FMT_SOFTIRQ_ENTRY_EXIT: parse_softirq_entry_exit, 877PRINT_FMT_SCHED_WAKEUP_HM: parse_sched_wakeup_hm, 878PRINT_FMT_SCHED_WAKEUP: parse_sched_wakeup, 879PRINT_FMT_SCHED_SWITCH_HM: parse_sched_switch_hm, 880PRINT_FMT_SCHED_SWITCH_HM_NEW: parse_sched_switch_hm_new, 881PRINT_FMT_SCHED_SWITCH_HM_NINFO_CG: parse_sched_switch_hm_ninfo_cg, 882PRINT_FMT_SCHED_SWITCH: parse_sched_switch, 883PRINT_FMT_SCHED_BLOCKED_REASON_HM_OLD: parse_sched_blocked_reason_hm_old, 884PRINT_FMT_SCHED_BLOCKED_REASON_HM: parse_sched_blocked_reason_hm, 885PRINT_FMT_SCHED_BLOCKED_REASON: parse_sched_blocked_reason, 886PRINT_FMT_CPU_FREQUENCY_HM: parse_cpu_frequency, 887PRINT_FMT_CPU_FREQUENCY: parse_cpu_frequency, 888PRINT_FMT_CLOCK_SET_RATE_HM: parse_clock_set_rate, 889PRINT_FMT_CLOCK_SET_RATE: parse_clock_set_rate, 890PRINT_FMT_CPU_FREQUENCY_LIMITS_HM: parse_cpu_frequency_limits_hm, 891PRINT_FMT_CPU_FREQUENCY_LIMITS: parse_cpu_frequency_limits, 892PRINT_FMT_CPU_IDLE_HM: parse_cpu_idle, 893PRINT_FMT_CPU_IDLE: parse_cpu_idle, 894PRINT_FMT_EXT4_DA_WRITE_BEGIN: parse_ext4_da_write_begin, 895PRINT_FMT_EXT4_DA_WRITE_END: parse_ext4_da_write_end, 896PRINT_FMT_EXT4_SYNC_FILE_ENTER: parse_ext4_sync_file_enter, 897PRINT_FMT_EXT4_SYNC_FILE_EXIT: parse_ext4_sync_file_exit, 898PRINT_FMT_BLOCK_BIO_REMAP: parse_block_bio_remap, 899PRINT_FMT_BLOCK_BIO_REMAP_NEW: parse_block_bio_remap_new, 900PRINT_FMT_BLOCK_RQ_ISSUE_HM: parse_block_rq_issue_hm, 901PRINT_FMT_BLOCK_RQ_ISSUE_OR_INSERT: parse_block_rq_issue_or_insert, 902PRINT_FMT_BLOCK_RQ_COMPLETE_HM: parse_block_rq_complete_hm, 903PRINT_FMT_BLOCK_RQ_COMPLETE: parse_block_rq_complete, 904PRINT_FMT_UFSHCD_COMMAND_HM: parse_ufshcd_command_hm, 905PRINT_FMT_UFSHCD_COMMAND: parse_ufshcd_command, 906PRINT_FMT_UFSHCD_UPIU: parse_ufshcd_upiu, 907PRINT_FMT_UFSHCD_UIC_COMMAND: parse_ufshcd_uic_command, 908PRINT_FMT_UFSHCD_FUNCS: parse_ufshcd_funcs, 909PRINT_FMT_UFSHCD_PROFILE_FUNCS: parse_ufshcd_profile_funcs, 910PRINT_FMT_UFSHCD_AUTO_BKOPS_STATE: parse_ufshcd_auto_bkops_state, 911PRINT_FMT_UFSHCD_CLK_SCALING: parse_ufshcd_clk_scaling, 912PRINT_FMT_UFSHCD_CLK_GATING: parse_ufshcd_clk_gating, 913PRINT_FMT_I2C_READ: parse_i2c_read, 914PRINT_FMT_I2C_WRITE_OR_REPLY: parse_i2c_write_or_reply, 915PRINT_FMT_I2C_RESULT: parse_i2c_result, 916PRINT_FMT_SMBUS_READ: parse_smbus_read, 917PRINT_FMT_SMBUS_WRITE_OR_REPLY: parse_smbus_write_or_reply, 918PRINT_FMT_SMBUS_RESULT: parse_smbus_result, 919PRINT_FMT_REGULATOR_SET_VOLTAGE_COMPLETE: parse_regulator_set_voltage_complete, 920PRINT_FMT_REGULATOR_SET_VOLTAGE: parse_regulator_set_voltage, 921PRINT_FMT_REGULATOR_FUNCS: parse_regulator_funcs, 922PRINT_FMT_DMA_FENCE_FUNCS: parse_dma_fence_funcs, 923PRINT_FMT_BINDER_TRANSACTION: parse_binder_transaction, 924PRINT_FMT_BINDER_TRANSACTION_RECEIVED: parse_binder_transaction_received, 925PRINT_FMT_MMC_REQUEST_START: parse_mmc_request_start, 926PRINT_FMT_MMC_REQUEST_DONE: parse_mmc_request_done, 927PRINT_FMT_FILE_CHECK_AND_ADVANCE_WB_ERR: parse_file_check_and_advance_wb_err, 928PRINT_FMT_FILEMAP_SET_WB_ERR: parse_filemap_set_wb_err, 929PRINT_FMT_MM_FILEMAP_ADD_OR_DELETE_PAGE_CACHE: parse_mm_filemap_add_or_delete_page_cache, 930PRINT_FMT_MM_FILEMAP_ADD_OR_DELETE_PAGE_CACHE_NEW: parse_mm_filemap_add_or_delete_page_cache_new, 931PRINT_FMT_RSS_STAT_HM: parse_rss_stat, 932PRINT_FMT_WORKQUEUE_EXECUTE_START_OR_END: parse_workqueue_execute_start_or_end, 933PRINT_FMT_THERMAL_POWER_ALLOCATOR_PID: parse_thermal_power_allocator_pid, 934PRINT_FMT_THERMAL_POWER_ALLOCATOR: parse_thermal_power_allocator, 935PRINT_FMT_PRINT: parse_print, 936PRINT_FMT_TRACING_MARK_WRITE: parse_tracing_mark_write, 937PRINT_FMT_XACCT_TRACING_MARK_WRITE: parse_xacct_tracing_mark_write 938} 939