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 # target-s390x/mmu_helper.c
 141 get_skeys_nonzero(int rc) "SKEY: Call to get_skeys unexpectedly returned %d"
 142 set_skeys_nonzero(int rc) "SKEY: Call to set_skeys unexpectedly returned %d"
 143
 144 # target-s390x/ioinst.c
 145 ioinst(const char *insn) "IOINST: %s"
 146 ioinst_sch_id(const char *insn, int cssid, int ssid, int schid) "IOINST: %s (%x.%x.%04x)"
 147 ioinst_chp_id(const char *insn, int cssid, int chpid) "IOINST: %s (%x.%02x)"
 148 ioinst_chsc_cmd(uint16_t cmd, uint16_t len) "IOINST: chsc command %04x, len %04x"
 149
 150 # kvm-all.c
 151 kvm_ioctl(int type, void *arg) "type 0x%x, arg %p"
 152 kvm_vm_ioctl(int type, void *arg) "type 0x%x, arg %p"
 153 kvm_vcpu_ioctl(int cpu_index, int type, void *arg) "cpu_index %d, type 0x%x, arg %p"
 154 kvm_run_exit(int cpu_index, uint32_t reason) "cpu_index %d, reason %d"
 155 kvm_device_ioctl(int fd, int type, void *arg) "dev fd %d, type 0x%x, arg %p"
 156 kvm_failed_reg_get(uint64_t id, const char *msg) "Warning: Unable to retrieve ONEREG %" PRIu64 " from KVM: %s"
 157 kvm_failed_reg_set(uint64_t id, const char *msg) "Warning: Unable to set ONEREG %" PRIu64 " to KVM: %s"
 158
 159 # target-ppc/kvm.c
 160 kvm_failed_spr_set(int str, const char *msg) "Warning: Unable to set SPR %d to KVM: %s"
 161 kvm_failed_spr_get(int str, const char *msg) "Warning: Unable to retrieve SPR %d from KVM: %s"
 162
 163 # TCG related tracing (mostly disabled by default)
 164 # cpu-exec.c
 165 disable exec_tb(void *tb, uintptr_t pc) "tb:%p pc=0x%"PRIxPTR
 166 disable exec_tb_nocache(void *tb, uintptr_t pc) "tb:%p pc=0x%"PRIxPTR
 167 disable exec_tb_exit(void *last_tb, unsigned int flags) "tb:%p flags=%x"
 168
 169 # translate-all.c
 170 translate_block(void *tb, uintptr_t pc, uint8_t *tb_code) "tb:%p, pc:0x%"PRIxPTR", tb_code:%p"
 171
 172 # memory.c
 173 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"
 174 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"
 175 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"
 176 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"
 177 memory_region_tb_read(int cpu_index, uint64_t addr, uint64_t value, unsigned size) "cpu %d addr %#"PRIx64" value %#"PRIx64" size %u"
 178 memory_region_tb_write(int cpu_index, uint64_t addr, uint64_t value, unsigned size) "cpu %d addr %#"PRIx64" value %#"PRIx64" size %u"
 179
 180 # qom/object.c
 181 object_dynamic_cast_assert(const char *type, const char *target, const char *file, int line, const char *func) "%s->%s (%s:%d:%s)"
 182 object_class_dynamic_cast_assert(const char *type, const char *target, const char *file, int line, const char *func) "%s->%s (%s:%d:%s)"
 183
 184 # target-s390x/kvm.c
 185 kvm_enable_cmma(int rc) "CMMA: enabling with result code %d"
 186 kvm_clear_cmma(int rc) "CMMA: clearing with result code %d"
 187 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"
 188 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"
 189
 190 # target-s390x/cpu.c
 191 cpu_set_state(int cpu_index, uint8_t state) "setting cpu %d state to %" PRIu8
 192 cpu_halt(int cpu_index) "halting cpu %d"
 193 cpu_unhalt(int cpu_index) "unhalting cpu %d"
 194
 195 # audio/alsaaudio.c
 196 alsa_revents(int revents) "revents = %d"
 197 alsa_pollout(int i, int fd) "i = %d fd = %d"
 198 alsa_set_handler(int events, int index, int fd, int err) "events=%#x index=%d fd=%d err=%d"
 199 alsa_wrote_zero(int len) "Failed to write %d frames (wrote zero)"
 200 alsa_read_zero(long len) "Failed to read %ld frames (read zero)"
 201 alsa_xrun_out(void) "Recovering from playback xrun"
 202 alsa_xrun_in(void) "Recovering from capture xrun"
 203 alsa_resume_out(void) "Resuming suspended output stream"
 204 alsa_resume_in(void) "Resuming suspended input stream"
 205 alsa_no_frames(int state) "No frames available and ALSA state is %d"
 206
 207 # audio/ossaudio.c
 208 oss_version(int version) "OSS version = %#x"
 209 oss_invalid_available_size(int size, int bufsize) "Invalid available size, size=%d bufsize=%d"
 210
 211 # net/vhost-user.c
 212 vhost_user_event(const char *chr, int event) "chr: %s got event: %d"
 213
 214 # linux-user/signal.c
 215 user_setup_frame(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 216 user_setup_rt_frame(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 217 user_do_rt_sigreturn(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 218 user_do_sigreturn(void *env, uint64_t frame_addr) "env=%p frame_addr=%"PRIx64
 219 user_force_sig(void *env, int target_sig, int host_sig) "env=%p signal %d (host %d)"
 220 user_handle_signal(void *env, int target_sig) "env=%p signal %d"
 221 user_host_signal(void *env, int host_sig, int target_sig) "env=%p signal %d (target %d("
 222 user_queue_signal(void *env, int target_sig) "env=%p signal %d"
 223 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
 224
 225 ### Guest events, keep at bottom
 226
 227 # @vaddr: Access' virtual address.
 228 # @info : Access' information (see below).
 229 #
 230 # Start virtual memory access (before any potential access violation).
 231 #
 232 # Does not include memory accesses performed by devices.
 233 #
 234 # Access information can be parsed as:
 235 #
 236 # struct mem_info {
 237 #     uint8_t size_shift : 2; /* interpreted as "1 << size_shift" bytes */
 238 #     bool    sign_extend: 1; /* sign-extended */
 239 #     uint8_t endianness : 1; /* 0: little, 1: big */
 240 #     bool    store      : 1; /* wheter it's a store operation */
 241 # };
 242 #
 243 # Targets: TCG(all)
 244 disable vcpu tcg guest_mem_before(TCGv vaddr, uint8_t info) "info=%d", "vaddr=0x%016"PRIx64" info=%d"