trace-events

   1 # Trace events for debugging and performance instrumentation
   2 #
   3 # This file is processed by the tracetool script during the build.
   4 #
   5 # To add a new trace event:
   6 #
   7 # 1. Choose a name for the trace event.  Declare its arguments and format
   8 #    string.
   9 #
  10 # 2. Call the trace event from code using trace_##name, e.g. multiwrite_cb() ->
  11 #    trace_multiwrite_cb().  The source file must #include "trace.h".
  12 #
  13 # Format of a trace event:
  14 #
  15 # [disable] <name>(<type1> <arg1>[, <type2> <arg2>] ...) "<format-string>"
  16 #
  17 # Example: g_malloc(size_t size) "size %zu"
  18 #
  19 # The "disable" keyword will build without the trace event.
  20 #
  21 # The <name> must be a valid as a C function name.
  22 #
  23 # Types should be standard C types.  Use void * for pointers because the trace
  24 # system may not have the necessary headers included.
  25 #
  26 # The <format-string> should be a sprintf()-compatible format string.
  27
  28 # thread-pool.c
  29 thread_pool_submit(void *pool, void *req, void *opaque) "pool %p req %p opaque %p"
  30 thread_pool_complete(void *pool, void *req, void *opaque, int ret) "pool %p req %p opaque %p ret %d"
  31 thread_pool_cancel(void *req, void *opaque) "req %p opaque %p"
  32
  33 # ioport.c
  34 cpu_in(unsigned int addr, char size, unsigned int val) "addr %#x(%c) value %u"
  35 cpu_out(unsigned int addr, char size, unsigned int val) "addr %#x(%c) value %u"
  36
  37 # balloon.c
  38 # Since requests are raised via monitor, not many tracepoints are needed.
  39 balloon_event(void *opaque, unsigned long addr) "opaque %p addr %lu"
  40 virtio_balloon_handle_output(const char *name, uint64_t gpa) "section name: %s gpa: %"PRIx64
  41 virtio_balloon_get_config(uint32_t num_pages, uint32_t actual) "num_pages: %d actual: %d"
  42 virtio_balloon_set_config(uint32_t actual, uint32_t oldactual) "actual: %d oldactual: %d"
  43 virtio_balloon_to_target(uint64_t target, uint32_t num_pages) "balloon target: %"PRIx64" num_pages: %d"
  44
  45 # vl.c
  46 vm_state_notify(int running, int reason) "running %d reason %d"
  47 load_file(const char *name, const char *path) "name %s location %s"
  48 runstate_set(int new_state) "new state %d"
  49 system_wakeup_request(int reason) "reason=%d"
  50 qemu_system_shutdown_request(void) ""
  51 qemu_system_powerdown_request(void) ""
  52
  53 # spice-qemu-char.c
  54 spice_vmc_write(ssize_t out, int len) "spice wrottn %zd of requested %d"
  55 spice_vmc_read(int bytes, int len) "spice read %d of requested %d"
  56 spice_vmc_register_interface(void *scd) "spice vmc registered interface %p"
  57 spice_vmc_unregister_interface(void *scd) "spice vmc unregistered interface %p"
  58 spice_vmc_event(int event) "spice vmc event %d"
  59
  60 # xen-hvm.c
  61 xen_ram_alloc(unsigned long ram_addr, unsigned long size) "requested: %#lx, size %#lx"
  62 xen_client_set_memory(uint64_t start_addr, unsigned long size, bool log_dirty) "%#"PRIx64" size %#lx, log_dirty %i"
  63 xen_ioreq_server_create(uint32_t id) "id: %u"
  64 xen_ioreq_server_destroy(uint32_t id) "id: %u"
  65 xen_ioreq_server_state(uint32_t id, bool enable) "id: %u: enable: %i"
  66 xen_map_mmio_range(uint32_t id, uint64_t start_addr, uint64_t end_addr) "id: %u start: %#"PRIx64" end: %#"PRIx64
  67 xen_unmap_mmio_range(uint32_t id, uint64_t start_addr, uint64_t end_addr) "id: %u start: %#"PRIx64" end: %#"PRIx64
  68 xen_map_portio_range(uint32_t id, uint64_t start_addr, uint64_t end_addr) "id: %u start: %#"PRIx64" end: %#"PRIx64
  69 xen_unmap_portio_range(uint32_t id, uint64_t start_addr, uint64_t end_addr) "id: %u start: %#"PRIx64" end: %#"PRIx64
  70 xen_map_pcidev(uint32_t id, uint8_t bus, uint8_t dev, uint8_t func) "id: %u bdf: %02x.%02x.%02x"
  71 xen_unmap_pcidev(uint32_t id, uint8_t bus, uint8_t dev, uint8_t func) "id: %u bdf: %02x.%02x.%02x"
  72 handle_ioreq(void *req, uint32_t type, uint32_t dir, uint32_t df, uint32_t data_is_ptr, uint64_t addr, uint64_t data, uint32_t count, uint32_t size) "I/O=%p type=%d dir=%d df=%d ptr=%d port=%#"PRIx64" data=%#"PRIx64" count=%d size=%d"
  73 handle_ioreq_read(void *req, uint32_t type, uint32_t df, uint32_t data_is_ptr, uint64_t addr, uint64_t data, uint32_t count, uint32_t size) "I/O=%p read type=%d df=%d ptr=%d port=%#"PRIx64" data=%#"PRIx64" count=%d size=%d"
  74 handle_ioreq_write(void *req, uint32_t type, uint32_t df, uint32_t data_is_ptr, uint64_t addr, uint64_t data, uint32_t count, uint32_t size) "I/O=%p write type=%d df=%d ptr=%d port=%#"PRIx64" data=%#"PRIx64" count=%d size=%d"
  75 cpu_ioreq_pio(void *req, uint32_t dir, uint32_t df, uint32_t data_is_ptr, uint64_t addr, uint64_t data, uint32_t count, uint32_t size) "I/O=%p pio dir=%d df=%d ptr=%d port=%#"PRIx64" data=%#"PRIx64" count=%d size=%d"
  76 cpu_ioreq_pio_read_reg(void *req, uint64_t data, uint64_t addr, uint32_t size) "I/O=%p pio read reg data=%#"PRIx64" port=%#"PRIx64" size=%d"
  77 cpu_ioreq_pio_write_reg(void *req, uint64_t data, uint64_t addr, uint32_t size) "I/O=%p pio write reg data=%#"PRIx64" port=%#"PRIx64" size=%d"
  78 cpu_ioreq_move(void *req, uint32_t dir, uint32_t df, uint32_t data_is_ptr, uint64_t addr, uint64_t data, uint32_t count, uint32_t size) "I/O=%p copy dir=%d df=%d ptr=%d port=%#"PRIx64" data=%#"PRIx64" count=%d size=%d"
  79
  80 # xen-mapcache.c
  81 xen_map_cache(uint64_t phys_addr) "want %#"PRIx64
  82 xen_remap_bucket(uint64_t index) "index %#"PRIx64
  83 xen_map_cache_return(void* ptr) "%p"
  84
  85 # qemu-coroutine.c
  86 qemu_coroutine_enter(void *from, void *to, void *opaque) "from %p to %p opaque %p"
  87 qemu_coroutine_yield(void *from, void *to) "from %p to %p"
  88 qemu_coroutine_terminate(void *co) "self %p"
  89
  90 # qemu-coroutine-lock.c
  91 qemu_co_queue_run_restart(void *co) "co %p"
  92 qemu_co_queue_next(void *nxt) "next %p"
  93 qemu_co_mutex_lock_entry(void *mutex, void *self) "mutex %p self %p"
  94 qemu_co_mutex_lock_return(void *mutex, void *self) "mutex %p self %p"
  95 qemu_co_mutex_unlock_entry(void *mutex, void *self) "mutex %p self %p"
  96 qemu_co_mutex_unlock_return(void *mutex, void *self) "mutex %p self %p"
  97
  98 # monitor.c
  99 handle_qmp_command(void *mon, const char *cmd_name) "mon %p cmd_name \"%s\""
 100 monitor_protocol_emitter(void *mon) "mon %p"
 101 monitor_protocol_event_handler(uint32_t event, void *qdict) "event=%d data=%p"
 102 monitor_protocol_event_emit(uint32_t event, void *data) "event=%d data=%p"
 103 monitor_protocol_event_queue(uint32_t event, void *qdict, uint64_t rate) "event=%d data=%p rate=%" PRId64
 104 monitor_protocol_event_throttle(uint32_t event, uint64_t rate) "event=%d rate=%" PRId64
 105
 106 # target-sparc/mmu_helper.c
 107 mmu_helper_dfault(uint64_t address, uint64_t context, int mmu_idx, uint32_t tl) "DFAULT at %"PRIx64" context %"PRIx64" mmu_idx=%d tl=%d"
 108 mmu_helper_dprot(uint64_t address, uint64_t context, int mmu_idx, uint32_t tl) "DPROT at %"PRIx64" context %"PRIx64" mmu_idx=%d tl=%d"
 109 mmu_helper_dmiss(uint64_t address, uint64_t context) "DMISS at %"PRIx64" context %"PRIx64
 110 mmu_helper_tfault(uint64_t address, uint64_t context) "TFAULT at %"PRIx64" context %"PRIx64
 111 mmu_helper_tmiss(uint64_t address, uint64_t context) "TMISS at %"PRIx64" context %"PRIx64
 112 mmu_helper_get_phys_addr_code(uint32_t tl, int mmu_idx, uint64_t prim_context, uint64_t sec_context, uint64_t address) "tl=%d mmu_idx=%d primary context=%"PRIx64" secondary context=%"PRIx64" address=%"PRIx64
 113 mmu_helper_get_phys_addr_data(uint32_t tl, int mmu_idx, uint64_t prim_context, uint64_t sec_context, uint64_t address) "tl=%d mmu_idx=%d primary context=%"PRIx64" secondary context=%"PRIx64" address=%"PRIx64
 114 mmu_helper_mmu_fault(uint64_t address, uint64_t paddr, int mmu_idx, uint32_t tl, uint64_t prim_context, uint64_t sec_context) "Translate at %"PRIx64" -> %"PRIx64", mmu_idx=%d tl=%d primary context=%"PRIx64" secondary context=%"PRIx64
 115
 116 # target-sparc/int64_helper.c
 117 int_helper_set_softint(uint32_t softint) "new %08x"
 118 int_helper_clear_softint(uint32_t softint) "new %08x"
 119 int_helper_write_softint(uint32_t softint) "new %08x"
 120
 121 # target-sparc/int32_helper.c
 122 int_helper_icache_freeze(void) "Instruction cache: freeze"
 123 int_helper_dcache_freeze(void) "Data cache: freeze"
 124
 125 # target-sparc/win_helper.c
 126 win_helper_gregset_error(uint32_t pstate) "ERROR in get_gregset: active pstate bits=%x"
 127 win_helper_switch_pstate(uint32_t pstate_regs, uint32_t new_pstate_regs) "change_pstate: switching regs old=%x new=%x"
 128 win_helper_no_switch_pstate(uint32_t new_pstate_regs) "change_pstate: regs new=%x (unchanged)"
 129 win_helper_wrpil(uint32_t psrpil, uint32_t new_pil) "old=%x new=%x"
 130 win_helper_done(uint32_t tl) "tl=%d"
 131 win_helper_retry(uint32_t tl) "tl=%d"
 132
 133 # dma-helpers.c
 134 dma_blk_io(void *dbs, void *bs, int64_t offset, bool to_dev) "dbs=%p bs=%p offset=%" PRId64 " to_dev=%d"
 135 dma_aio_cancel(void *dbs) "dbs=%p"
 136 dma_complete(void *dbs, int ret, void *cb) "dbs=%p ret=%d cb=%p"
 137 dma_blk_cb(void *dbs, int ret) "dbs=%p ret=%d"
 138 dma_map_wait(void *dbs) "dbs=%p"
 139
 140 # ui/console.c
 141 console_gfx_new(void) ""
 142 console_putchar_csi(int esc_param0, int esc_param1, int ch, int nb_esc_params) "escape sequence CSI%d;%d%c, %d parameters"
 143 console_putchar_unhandled(int ch) "unhandled escape character '%c'"
 144 console_txt_new(int w, int h) "%dx%d"
 145 console_select(int nr) "%d"
 146 console_refresh(int interval) "interval %d ms"
 147 displaysurface_create(void *display_surface, int w, int h) "surface=%p, %dx%d"
 148 displaysurface_create_from(void *display_surface, int w, int h, uint32_t format) "surface=%p, %dx%d, format 0x%x"
 149 displaysurface_create_pixman(void *display_surface) "surface=%p"
 150 displaysurface_free(void *display_surface) "surface=%p"
 151 displaychangelistener_register(void *dcl, const char *name) "%p [ %s ]"
 152 displaychangelistener_unregister(void *dcl, const char *name) "%p [ %s ]"
 153 ppm_save(const char *filename, void *display_surface) "%s surface=%p"
 154
 155 # ui/gtk.c
 156 gd_switch(const char *tab, int width, int height) "tab=%s, width=%d, height=%d"
 157 gd_update(const char *tab, int x, int y, int w, int h) "tab=%s, x=%d, y=%d, w=%d, h=%d"
 158 gd_key_event(const char *tab, int gdk_keycode, int qemu_keycode, const char *action) "tab=%s, translated GDK keycode %d to QEMU keycode %d (%s)"
 159 gd_grab(const char *tab, const char *device, const char *reason) "tab=%s, dev=%s, reason=%s"
 160 gd_ungrab(const char *tab, const char *device) "tab=%s, dev=%s"
 161
 162 # ui/vnc.c
 163 vnc_key_guest_leds(bool caps, bool num, bool scroll) "caps %d, num %d, scroll %d"
 164 vnc_key_map_init(const char *layout) "%s"
 165 vnc_key_event_ext(bool down, int sym, int keycode, const char *name) "down %d, sym 0x%x, keycode 0x%x [%s]"
 166 vnc_key_event_map(bool down, int sym, int keycode, const char *name) "down %d, sym 0x%x -> keycode 0x%x [%s]"
 167 vnc_key_sync_numlock(bool on) "%d"
 168 vnc_key_sync_capslock(bool on) "%d"
 169
 170 # ui/input.c
 171 input_event_key_number(int conidx, int number, const char *qcode, bool down) "con %d, key number 0x%x [%s], down %d"
 172 input_event_key_qcode(int conidx, const char *qcode, bool down) "con %d, key qcode %s, down %d"
 173 input_event_btn(int conidx, const char *btn, bool down) "con %d, button %s, down %d"
 174 input_event_rel(int conidx, const char *axis, int value) "con %d, axis %s, value %d"
 175 input_event_abs(int conidx, const char *axis, int value) "con %d, axis %s, value 0x%x"
 176 input_event_sync(void) ""
 177 input_mouse_mode(int absolute) "absolute %d"
 178
 179 # ui/spice-display.c
 180 qemu_spice_add_memslot(int qid, uint32_t slot_id, unsigned long virt_start, unsigned long virt_end, int async) "%d %u: host virt 0x%lx - 0x%lx async=%d"
 181 qemu_spice_del_memslot(int qid, uint32_t gid, uint32_t slot_id) "%d gid=%u sid=%u"
 182 qemu_spice_create_primary_surface(int qid, uint32_t sid, void *surface, int async) "%d sid=%u surface=%p async=%d"
 183 qemu_spice_destroy_primary_surface(int qid, uint32_t sid, int async) "%d sid=%u async=%d"
 184 qemu_spice_wakeup(uint32_t qid) "%d"
 185 qemu_spice_create_update(uint32_t left, uint32_t right, uint32_t top, uint32_t bottom) "lr %d -> %d,  tb -> %d -> %d"
 186
 187 # target-s390x/mmu_helper.c
 188 get_skeys_nonzero(int rc) "SKEY: Call to get_skeys unexpectedly returned %d"
 189 set_skeys_nonzero(int rc) "SKEY: Call to set_skeys unexpectedly returned %d"
 190
 191 # target-s390x/ioinst.c
 192 ioinst(const char *insn) "IOINST: %s"
 193 ioinst_sch_id(const char *insn, int cssid, int ssid, int schid) "IOINST: %s (%x.%x.%04x)"
 194 ioinst_chp_id(const char *insn, int cssid, int chpid) "IOINST: %s (%x.%02x)"
 195 ioinst_chsc_cmd(uint16_t cmd, uint16_t len) "IOINST: chsc command %04x, len %04x"
 196
 197 # kvm-all.c
 198 kvm_ioctl(int type, void *arg) "type 0x%x, arg %p"
 199 kvm_vm_ioctl(int type, void *arg) "type 0x%x, arg %p"
 200 kvm_vcpu_ioctl(int cpu_index, int type, void *arg) "cpu_index %d, type 0x%x, arg %p"
 201 kvm_run_exit(int cpu_index, uint32_t reason) "cpu_index %d, reason %d"
 202 kvm_device_ioctl(int fd, int type, void *arg) "dev fd %d, type 0x%x, arg %p"
 203 kvm_failed_reg_get(uint64_t id, const char *msg) "Warning: Unable to retrieve ONEREG %" PRIu64 " from KVM: %s"
 204 kvm_failed_reg_set(uint64_t id, const char *msg) "Warning: Unable to set ONEREG %" PRIu64 " to KVM: %s"
 205
 206 # target-ppc/kvm.c
 207 kvm_failed_spr_set(int str, const char *msg) "Warning: Unable to set SPR %d to KVM: %s"
 208 kvm_failed_spr_get(int str, const char *msg) "Warning: Unable to retrieve SPR %d from KVM: %s"
 209
 210 # TCG related tracing (mostly disabled by default)
 211 # cpu-exec.c
 212 disable exec_tb(void *tb, uintptr_t pc) "tb:%p pc=0x%"PRIxPTR
 213 disable exec_tb_nocache(void *tb, uintptr_t pc) "tb:%p pc=0x%"PRIxPTR
 214 disable exec_tb_exit(void *last_tb, unsigned int flags) "tb:%p flags=%x"
 215
 216 # translate-all.c
 217 translate_block(void *tb, uintptr_t pc, uint8_t *tb_code) "tb:%p, pc:0x%"PRIxPTR", tb_code:%p"
 218
 219 # memory.c
 220 memory_region_ops_read(int cpu_index, void *mr, uint64_t addr, uint64_t value, unsigned size) "cpu %d mr %p addr %#"PRIx64" value %#"PRIx64" size %u"
 221 memory_region_ops_write(int cpu_index, void *mr, uint64_t addr, uint64_t value, unsigned size) "cpu %d mr %p addr %#"PRIx64" value %#"PRIx64" size %u"
 222 memory_region_subpage_read(int cpu_index, void *mr, uint64_t offset, uint64_t value, unsigned size) "cpu %d mr %p offset %#"PRIx64" value %#"PRIx64" size %u"
 223 memory_region_subpage_write(int cpu_index, void *mr, uint64_t offset, uint64_t value, unsigned size) "cpu %d mr %p offset %#"PRIx64" value %#"PRIx64" size %u"
 224 memory_region_tb_read(int cpu_index, uint64_t addr, uint64_t value, unsigned size) "cpu %d addr %#"PRIx64" value %#"PRIx64" size %u"
 225 memory_region_tb_write(int cpu_index, uint64_t addr, uint64_t value, unsigned size) "cpu %d addr %#"PRIx64" value %#"PRIx64" size %u"
 226
 227 # qom/object.c
 228 object_dynamic_cast_assert(const char *type, const char *target, const char *file, int line, const char *func) "%s->%s (%s:%d:%s)"
 229 object_class_dynamic_cast_assert(const char *type, const char *target, const char *file, int line, const char *func) "%s->%s (%s:%d:%s)"
 230
 231 # target-s390x/kvm.c
 232 kvm_enable_cmma(int rc) "CMMA: enabling with result code %d"
 233 kvm_clear_cmma(int rc) "CMMA: clearing with result code %d"
 234 kvm_failed_cpu_state_set(int cpu_index, uint8_t state, const char *msg) "Warning: Unable to set cpu %d state %" PRIu8 " to KVM: %s"
 235 kvm_sigp_finished(uint8_t order, int cpu_index, int dst_index, int cc) "SIGP: Finished order %u on cpu %d -> cpu %d with cc=%d"
 236
 237 # target-s390x/cpu.c
 238 cpu_set_state(int cpu_index, uint8_t state) "setting cpu %d state to %" PRIu8
 239 cpu_halt(int cpu_index) "halting cpu %d"
 240 cpu_unhalt(int cpu_index) "unhalting cpu %d"
 241
 242 # audio/alsaaudio.c
 243 alsa_revents(int revents) "revents = %d"
 244 alsa_pollout(int i, int fd) "i = %d fd = %d"
 245 alsa_set_handler(int events, int index, int fd, int err) "events=%#x index=%d fd=%d err=%d"
 246 alsa_wrote_zero(int len) "Failed to write %d frames (wrote zero)"
 247 alsa_read_zero(long len) "Failed to read %ld frames (read zero)"
 248 alsa_xrun_out(void) "Recovering from playback xrun"
 249 alsa_xrun_in(void) "Recovering from capture xrun"
 250 alsa_resume_out(void) "Resuming suspended output stream"
 251 alsa_resume_in(void) "Resuming suspended input stream"
 252 alsa_no_frames(int state) "No frames available and ALSA state is %d"
 253
 254 # audio/ossaudio.c
 255 oss_version(int version) "OSS version = %#x"
 256 oss_invalid_available_size(int size, int bufsize) "Invalid available size, size=%d bufsize=%d"
 257
 258 # net/vhost-user.c
 259 vhost_user_event(const char *chr, int event) "chr: %s got event: %d"
 260
 261 # linux-user/signal.c
 262 user_setup_frame(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 263 user_setup_rt_frame(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 264 user_do_rt_sigreturn(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 265 user_do_sigreturn(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 266 user_force_sig(void *env, int target_sig, int host_sig) "env=%p signal %d (host %d)"
 267 user_handle_signal(void *env, int target_sig) "env=%p signal %d"
 268 user_host_signal(void *env, int host_sig, int target_sig) "env=%p signal %d (target %d("
 269 user_queue_signal(void *env, int target_sig) "env=%p signal %d"
 270 user_s390x_restore_sigregs(void *env, uint64_t sc_psw_addr, uint64_t env_psw_addr) "env=%p frame psw.addr %"PRIx64 " current psw.addr %"PRIx64
 271
 272 ### Guest events, keep at bottom
 273
 274 # @vaddr: Access' virtual address.
 275 # @info : Access' information (see below).
 276 #
 277 # Start virtual memory access (before any potential access violation).
 278 #
 279 # Does not include memory accesses performed by devices.
 280 #
 281 # Access information can be parsed as:
 282 #
 283 # struct mem_info {
 284 #     uint8_t size_shift : 2; /* interpreted as "1 << size_shift" bytes */
 285 #     bool    sign_extend: 1; /* sign-extended */
 286 #     uint8_t endianness : 1; /* 0: little, 1: big */
 287 #     bool    store      : 1; /* wheter it's a store operation */
 288 # };
 289 #
 290 # Targets: TCG(all)
 291 disable vcpu tcg guest_mem_before(TCGv vaddr, uint8_t info) "info=%d", "vaddr=0x%016"PRIx64" info=%d"