xref: /openbmc/qemu/migration/trace-events (revision 4b9fa0b4)
1# See docs/devel/tracing.txt for syntax documentation.
2
3# savevm.c
4qemu_loadvm_state_section(unsigned int section_type) "%d"
5qemu_loadvm_state_section_command(int ret) "%d"
6qemu_loadvm_state_section_partend(uint32_t section_id) "%u"
7qemu_loadvm_state_post_main(int ret) "%d"
8qemu_loadvm_state_section_startfull(uint32_t section_id, const char *idstr, uint32_t instance_id, uint32_t version_id) "%u(%s) %u %u"
9qemu_savevm_send_packaged(void) ""
10loadvm_state_setup(void) ""
11loadvm_state_cleanup(void) ""
12loadvm_handle_cmd_packaged(unsigned int length) "%u"
13loadvm_handle_cmd_packaged_main(int ret) "%d"
14loadvm_handle_cmd_packaged_received(int ret) "%d"
15loadvm_handle_recv_bitmap(char *s) "%s"
16loadvm_postcopy_handle_advise(void) ""
17loadvm_postcopy_handle_listen(void) ""
18loadvm_postcopy_handle_run(void) ""
19loadvm_postcopy_handle_run_cpu_sync(void) ""
20loadvm_postcopy_handle_run_vmstart(void) ""
21loadvm_postcopy_handle_resume(void) ""
22loadvm_postcopy_ram_handle_discard(void) ""
23loadvm_postcopy_ram_handle_discard_end(void) ""
24loadvm_postcopy_ram_handle_discard_header(const char *ramid, uint16_t len) "%s: %ud"
25loadvm_process_command(uint16_t com, uint16_t len) "com=0x%x len=%d"
26loadvm_process_command_ping(uint32_t val) "0x%x"
27postcopy_ram_listen_thread_exit(void) ""
28postcopy_ram_listen_thread_start(void) ""
29qemu_savevm_send_postcopy_advise(void) ""
30qemu_savevm_send_postcopy_ram_discard(const char *id, uint16_t len) "%s: %ud"
31savevm_command_send(uint16_t command, uint16_t len) "com=0x%x len=%d"
32savevm_section_start(const char *id, unsigned int section_id) "%s, section_id %u"
33savevm_section_end(const char *id, unsigned int section_id, int ret) "%s, section_id %u -> %d"
34savevm_section_skip(const char *id, unsigned int section_id) "%s, section_id %u"
35savevm_send_open_return_path(void) ""
36savevm_send_ping(uint32_t val) "0x%x"
37savevm_send_postcopy_listen(void) ""
38savevm_send_postcopy_run(void) ""
39savevm_send_postcopy_resume(void) ""
40savevm_send_colo_enable(void) ""
41savevm_send_recv_bitmap(char *name) "%s"
42savevm_state_setup(void) ""
43savevm_state_resume_prepare(void) ""
44savevm_state_header(void) ""
45savevm_state_iterate(void) ""
46savevm_state_cleanup(void) ""
47savevm_state_complete_precopy(void) ""
48vmstate_save(const char *idstr, const char *vmsd_name) "%s, %s"
49vmstate_load(const char *idstr, const char *vmsd_name) "%s, %s"
50postcopy_pause_incoming(void) ""
51postcopy_pause_incoming_continued(void) ""
52
53# vmstate.c
54vmstate_load_field_error(const char *field, int ret) "field \"%s\" load failed, ret = %d"
55vmstate_load_state(const char *name, int version_id) "%s v%d"
56vmstate_load_state_end(const char *name, const char *reason, int val) "%s %s/%d"
57vmstate_load_state_field(const char *name, const char *field) "%s:%s"
58vmstate_n_elems(const char *name, int n_elems) "%s: %d"
59vmstate_subsection_load(const char *parent) "%s"
60vmstate_subsection_load_bad(const char *parent,  const char *sub, const char *sub2) "%s: %s/%s"
61vmstate_subsection_load_good(const char *parent) "%s"
62vmstate_save_state_pre_save_res(const char *name, int res) "%s/%d"
63vmstate_save_state_loop(const char *name, const char *field, int n_elems) "%s/%s[%d]"
64vmstate_save_state_top(const char *idstr) "%s"
65vmstate_subsection_save_loop(const char *name, const char *sub) "%s/%s"
66vmstate_subsection_save_top(const char *idstr) "%s"
67
68# vmstate-types.c
69get_qtailq(const char *name, int version_id) "%s v%d"
70get_qtailq_end(const char *name, const char *reason, int val) "%s %s/%d"
71put_qtailq(const char *name, int version_id) "%s v%d"
72put_qtailq_end(const char *name, const char *reason) "%s %s"
73
74get_gtree(const char *field_name, const char *key_vmsd_name, const char *val_vmsd_name, uint32_t nnodes) "%s(%s/%s) nnodes=%d"
75get_gtree_end(const char *field_name, const char *key_vmsd_name, const char *val_vmsd_name, int ret) "%s(%s/%s) %d"
76put_gtree(const char *field_name, const char *key_vmsd_name, const char *val_vmsd_name, uint32_t nnodes) "%s(%s/%s) nnodes=%d"
77put_gtree_end(const char *field_name, const char *key_vmsd_name, const char *val_vmsd_name, int ret) "%s(%s/%s) %d"
78
79# qemu-file.c
80qemu_file_fclose(void) ""
81
82# ram.c
83get_queued_page(const char *block_name, uint64_t tmp_offset, unsigned long page_abs) "%s/0x%" PRIx64 " page_abs=0x%lx"
84get_queued_page_not_dirty(const char *block_name, uint64_t tmp_offset, unsigned long page_abs) "%s/0x%" PRIx64 " page_abs=0x%lx"
85migration_bitmap_sync_start(void) ""
86migration_bitmap_sync_end(uint64_t dirty_pages) "dirty_pages %" PRIu64
87migration_bitmap_clear_dirty(char *str, uint64_t start, uint64_t size, unsigned long page) "rb %s start 0x%"PRIx64" size 0x%"PRIx64" page 0x%lx"
88migration_throttle(void) ""
89multifd_new_send_channel_async(uint8_t id) "channel %d"
90multifd_recv(uint8_t id, uint64_t packet_num, uint32_t used, uint32_t flags, uint32_t next_packet_size) "channel %d packet_num %" PRIu64 " pages %d flags 0x%x next packet size %d"
91multifd_recv_new_channel(uint8_t id) "channel %d"
92multifd_recv_sync_main(long packet_num) "packet num %ld"
93multifd_recv_sync_main_signal(uint8_t id) "channel %d"
94multifd_recv_sync_main_wait(uint8_t id) "channel %d"
95multifd_recv_terminate_threads(bool error) "error %d"
96multifd_recv_thread_end(uint8_t id, uint64_t packets, uint64_t pages) "channel %d packets %" PRIu64 " pages %" PRIu64
97multifd_recv_thread_start(uint8_t id) "%d"
98multifd_save_setup_wait(uint8_t id) "%d"
99multifd_send(uint8_t id, uint64_t packet_num, uint32_t used, uint32_t flags, uint32_t next_packet_size) "channel %d packet_num %" PRIu64 " pages %d flags 0x%x next packet size %d"
100multifd_send_error(uint8_t id) "channel %d"
101multifd_send_sync_main(long packet_num) "packet num %ld"
102multifd_send_sync_main_signal(uint8_t id) "channel %d"
103multifd_send_sync_main_wait(uint8_t id) "channel %d"
104multifd_send_terminate_threads(bool error) "error %d"
105multifd_send_thread_end(uint8_t id, uint64_t packets, uint64_t pages) "channel %d packets %" PRIu64 " pages %"  PRIu64
106multifd_send_thread_start(uint8_t id) "%d"
107ram_discard_range(const char *rbname, uint64_t start, size_t len) "%s: start: %" PRIx64 " %zx"
108ram_load_loop(const char *rbname, uint64_t addr, int flags, void *host) "%s: addr: 0x%" PRIx64 " flags: 0x%x host: %p"
109ram_load_postcopy_loop(uint64_t addr, int flags) "@%" PRIx64 " %x"
110ram_postcopy_send_discard_bitmap(void) ""
111ram_save_page(const char *rbname, uint64_t offset, void *host) "%s: offset: 0x%" PRIx64 " host: %p"
112ram_save_queue_pages(const char *rbname, size_t start, size_t len) "%s: start: 0x%zx len: 0x%zx"
113ram_dirty_bitmap_request(char *str) "%s"
114ram_dirty_bitmap_reload_begin(char *str) "%s"
115ram_dirty_bitmap_reload_complete(char *str) "%s"
116ram_dirty_bitmap_sync_start(void) ""
117ram_dirty_bitmap_sync_wait(void) ""
118ram_dirty_bitmap_sync_complete(void) ""
119ram_state_resume_prepare(uint64_t v) "%" PRId64
120colo_flush_ram_cache_begin(uint64_t dirty_pages) "dirty_pages %" PRIu64
121colo_flush_ram_cache_end(void) ""
122save_xbzrle_page_skipping(void) ""
123save_xbzrle_page_overflow(void) ""
124ram_save_iterate_big_wait(uint64_t milliconds, int iterations) "big wait: %" PRIu64 " milliseconds, %d iterations"
125ram_load_complete(int ret, uint64_t seq_iter) "exit_code %d seq iteration %" PRIu64
126
127# migration.c
128await_return_path_close_on_source_close(void) ""
129await_return_path_close_on_source_joining(void) ""
130migrate_set_state(const char *new_state) "new state %s"
131migrate_fd_cleanup(void) ""
132migrate_fd_error(const char *error_desc) "error=%s"
133migrate_fd_cancel(void) ""
134migrate_handle_rp_req_pages(const char *rbname, size_t start, size_t len) "in %s at 0x%zx len 0x%zx"
135migrate_pending(uint64_t size, uint64_t max, uint64_t pre, uint64_t compat, uint64_t post) "pending size %" PRIu64 " max %" PRIu64 " (pre = %" PRIu64 " compat=%" PRIu64 " post=%" PRIu64 ")"
136migrate_send_rp_message(int msg_type, uint16_t len) "%d: len %d"
137migrate_send_rp_recv_bitmap(char *name, int64_t size) "block '%s' size 0x%"PRIi64
138migration_completion_file_err(void) ""
139migration_completion_postcopy_end(void) ""
140migration_completion_postcopy_end_after_complete(void) ""
141migration_return_path_end_before(void) ""
142migration_return_path_end_after(int rp_error) "%d"
143migration_thread_after_loop(void) ""
144migration_thread_file_err(void) ""
145migration_thread_ratelimit_pre(int ms) "%d ms"
146migration_thread_ratelimit_post(int urgent) "urgent: %d"
147migration_thread_setup_complete(void) ""
148open_return_path_on_source(void) ""
149open_return_path_on_source_continue(void) ""
150postcopy_start(void) ""
151postcopy_pause_return_path(void) ""
152postcopy_pause_return_path_continued(void) ""
153postcopy_pause_continued(void) ""
154postcopy_start_set_run(void) ""
155source_return_path_thread_bad_end(void) ""
156source_return_path_thread_end(void) ""
157source_return_path_thread_entry(void) ""
158source_return_path_thread_loop_top(void) ""
159source_return_path_thread_pong(uint32_t val) "0x%x"
160source_return_path_thread_shut(uint32_t val) "0x%x"
161source_return_path_thread_resume_ack(uint32_t v) "%"PRIu32
162migration_thread_low_pending(uint64_t pending) "%" PRIu64
163migrate_transferred(uint64_t tranferred, uint64_t time_spent, uint64_t bandwidth, uint64_t size) "transferred %" PRIu64 " time_spent %" PRIu64 " bandwidth %" PRIu64 " max_size %" PRId64
164process_incoming_migration_co_end(int ret, int ps) "ret=%d postcopy-state=%d"
165process_incoming_migration_co_postcopy_end_main(void) ""
166
167# channel.c
168migration_set_incoming_channel(void *ioc, const char *ioctype) "ioc=%p ioctype=%s"
169migration_set_outgoing_channel(void *ioc, const char *ioctype, const char *hostname, void *err)  "ioc=%p ioctype=%s hostname=%s err=%p"
170
171# global_state.c
172migrate_state_too_big(void) ""
173migrate_global_state_post_load(const char *state) "loaded state: %s"
174migrate_global_state_pre_save(const char *state) "saved state: %s"
175
176# rdma.c
177qemu_rdma_accept_incoming_migration(void) ""
178qemu_rdma_accept_incoming_migration_accepted(void) ""
179qemu_rdma_accept_pin_state(bool pin) "%d"
180qemu_rdma_accept_pin_verbsc(void *verbs) "Verbs context after listen: %p"
181qemu_rdma_block_for_wrid_miss(const char *wcompstr, int wcomp, const char *gcompstr, uint64_t req) "A Wanted wrid %s (%d) but got %s (%" PRIu64 ")"
182qemu_rdma_cleanup_disconnect(void) ""
183qemu_rdma_close(void) ""
184qemu_rdma_connect_pin_all_requested(void) ""
185qemu_rdma_connect_pin_all_outcome(bool pin) "%d"
186qemu_rdma_dest_init_trying(const char *host, const char *ip) "%s => %s"
187qemu_rdma_dump_gid(const char *who, const char *src, const char *dst) "%s Source GID: %s, Dest GID: %s"
188qemu_rdma_exchange_get_response_start(const char *desc) "CONTROL: %s receiving..."
189qemu_rdma_exchange_get_response_none(const char *desc, int type) "Surprise: got %s (%d)"
190qemu_rdma_exchange_send_issue_callback(void) ""
191qemu_rdma_exchange_send_waiting(const char *desc) "Waiting for response %s"
192qemu_rdma_exchange_send_received(const char *desc) "Response %s received."
193qemu_rdma_fill(size_t control_len, size_t size) "RDMA %zd of %zd bytes already in buffer"
194qemu_rdma_init_ram_blocks(int blocks) "Allocated %d local ram block structures"
195qemu_rdma_poll_recv(const char *compstr, int64_t comp, int64_t id, int sent) "completion %s #%" PRId64 " received (%" PRId64 ") left %d"
196qemu_rdma_poll_write(const char *compstr, int64_t comp, int left, uint64_t block, uint64_t chunk, void *local, void *remote) "completions %s (%" PRId64 ") left %d, block %" PRIu64 ", chunk: %" PRIu64 " %p %p"
197qemu_rdma_poll_other(const char *compstr, int64_t comp, int left) "other completion %s (%" PRId64 ") received left %d"
198qemu_rdma_post_send_control(const char *desc) "CONTROL: sending %s.."
199qemu_rdma_register_and_get_keys(uint64_t len, void *start) "Registering %" PRIu64 " bytes @ %p"
200qemu_rdma_registration_handle_compress(int64_t length, int index, int64_t offset) "Zapping zero chunk: %" PRId64 " bytes, index %d, offset %" PRId64
201qemu_rdma_registration_handle_finished(void) ""
202qemu_rdma_registration_handle_ram_blocks(void) ""
203qemu_rdma_registration_handle_ram_blocks_loop(const char *name, uint64_t offset, uint64_t length, void *local_host_addr, unsigned int src_index) "%s: @0x%" PRIx64 "/%" PRIu64 " host:@%p src_index: %u"
204qemu_rdma_registration_handle_register(int requests) "%d requests"
205qemu_rdma_registration_handle_register_loop(int req, int index, uint64_t addr, uint64_t chunks) "Registration request (%d): index %d, current_addr %" PRIu64 " chunks: %" PRIu64
206qemu_rdma_registration_handle_register_rkey(int rkey) "0x%x"
207qemu_rdma_registration_handle_unregister(int requests) "%d requests"
208qemu_rdma_registration_handle_unregister_loop(int count, int index, uint64_t chunk) "Unregistration request (%d): index %d, chunk %" PRIu64
209qemu_rdma_registration_handle_unregister_success(uint64_t chunk) "%" PRIu64
210qemu_rdma_registration_handle_wait(void) ""
211qemu_rdma_registration_start(uint64_t flags) "%" PRIu64
212qemu_rdma_registration_stop(uint64_t flags) "%" PRIu64
213qemu_rdma_registration_stop_ram(void) ""
214qemu_rdma_resolve_host_trying(const char *host, const char *ip) "Trying %s => %s"
215qemu_rdma_signal_unregister_append(uint64_t chunk, int pos) "Appending unregister chunk %" PRIu64 " at position %d"
216qemu_rdma_signal_unregister_already(uint64_t chunk) "Unregister chunk %" PRIu64 " already in queue"
217qemu_rdma_unregister_waiting_inflight(uint64_t chunk) "Cannot unregister inflight chunk: %" PRIu64
218qemu_rdma_unregister_waiting_proc(uint64_t chunk, int pos) "Processing unregister for chunk: %" PRIu64 " at position %d"
219qemu_rdma_unregister_waiting_send(uint64_t chunk) "Sending unregister for chunk: %" PRIu64
220qemu_rdma_unregister_waiting_complete(uint64_t chunk) "Unregister for chunk: %" PRIu64 " complete."
221qemu_rdma_write_flush(int sent) "sent total: %d"
222qemu_rdma_write_one_block(int count, int block, uint64_t chunk, uint64_t current, uint64_t len, int nb_sent, int nb_chunks) "(%d) Not clobbering: block: %d chunk %" PRIu64 " current %" PRIu64 " len %" PRIu64 " %d %d"
223qemu_rdma_write_one_post(uint64_t chunk, long addr, long remote, uint32_t len) "Posting chunk: %" PRIu64 ", addr: 0x%lx remote: 0x%lx, bytes %" PRIu32
224qemu_rdma_write_one_queue_full(void) ""
225qemu_rdma_write_one_recvregres(int mykey, int theirkey, uint64_t chunk) "Received registration result: my key: 0x%x their key 0x%x, chunk %" PRIu64
226qemu_rdma_write_one_sendreg(uint64_t chunk, int len, int index, int64_t offset) "Sending registration request chunk %" PRIu64 " for %d bytes, index: %d, offset: %" PRId64
227qemu_rdma_write_one_top(uint64_t chunks, uint64_t size) "Writing %" PRIu64 " chunks, (%" PRIu64 " MB)"
228qemu_rdma_write_one_zero(uint64_t chunk, int len, int index, int64_t offset) "Entire chunk is zero, sending compress: %" PRIu64 " for %d bytes, index: %d, offset: %" PRId64
229rdma_add_block(const char *block_name, int block, uint64_t addr, uint64_t offset, uint64_t len, uint64_t end, uint64_t bits, int chunks) "Added Block: '%s':%d, addr: %" PRIu64 ", offset: %" PRIu64 " length: %" PRIu64 " end: %" PRIu64 " bits %" PRIu64 " chunks %d"
230rdma_block_notification_handle(const char *name, int index) "%s at %d"
231rdma_delete_block(void *block, uint64_t addr, uint64_t offset, uint64_t len, uint64_t end, uint64_t bits, int chunks) "Deleted Block: %p, addr: %" PRIu64 ", offset: %" PRIu64 " length: %" PRIu64 " end: %" PRIu64 " bits %" PRIu64 " chunks %d"
232rdma_start_incoming_migration(void) ""
233rdma_start_incoming_migration_after_dest_init(void) ""
234rdma_start_incoming_migration_after_rdma_listen(void) ""
235rdma_start_outgoing_migration_after_rdma_connect(void) ""
236rdma_start_outgoing_migration_after_rdma_source_init(void) ""
237
238# postcopy-ram.c
239postcopy_discard_send_finish(const char *ramblock, int nwords, int ncmds) "%s mask words sent=%d in %d commands"
240postcopy_discard_send_range(const char *ramblock, unsigned long start, unsigned long length) "%s:%lx/%lx"
241postcopy_cleanup_range(const char *ramblock, void *host_addr, size_t offset, size_t length) "%s: %p offset=0x%zx length=0x%zx"
242postcopy_init_range(const char *ramblock, void *host_addr, size_t offset, size_t length) "%s: %p offset=0x%zx length=0x%zx"
243postcopy_nhp_range(const char *ramblock, void *host_addr, size_t offset, size_t length) "%s: %p offset=0x%zx length=0x%zx"
244postcopy_place_page(void *host_addr) "host=%p"
245postcopy_place_page_zero(void *host_addr) "host=%p"
246postcopy_ram_enable_notify(void) ""
247mark_postcopy_blocktime_begin(uint64_t addr, void *dd, uint32_t time, int cpu, int received) "addr: 0x%" PRIx64 ", dd: %p, time: %u, cpu: %d, already_received: %d"
248mark_postcopy_blocktime_end(uint64_t addr, void *dd, uint32_t time, int affected_cpu) "addr: 0x%" PRIx64 ", dd: %p, time: %u, affected_cpu: %d"
249postcopy_pause_fault_thread(void) ""
250postcopy_pause_fault_thread_continued(void) ""
251postcopy_ram_fault_thread_entry(void) ""
252postcopy_ram_fault_thread_exit(void) ""
253postcopy_ram_fault_thread_fds_core(int baseufd, int quitfd) "ufd: %d quitfd: %d"
254postcopy_ram_fault_thread_fds_extra(size_t index, const char *name, int fd) "%zd/%s: %d"
255postcopy_ram_fault_thread_quit(void) ""
256postcopy_ram_fault_thread_request(uint64_t hostaddr, const char *ramblock, size_t offset, uint32_t pid) "Request for HVA=0x%" PRIx64 " rb=%s offset=0x%zx pid=%u"
257postcopy_ram_incoming_cleanup_closeuf(void) ""
258postcopy_ram_incoming_cleanup_entry(void) ""
259postcopy_ram_incoming_cleanup_exit(void) ""
260postcopy_ram_incoming_cleanup_join(void) ""
261postcopy_ram_incoming_cleanup_blocktime(uint64_t total) "total blocktime %" PRIu64
262postcopy_request_shared_page(const char *sharer, const char *rb, uint64_t rb_offset) "for %s in %s offset 0x%"PRIx64
263postcopy_request_shared_page_present(const char *sharer, const char *rb, uint64_t rb_offset) "%s already %s offset 0x%"PRIx64
264postcopy_wake_shared(uint64_t client_addr, const char *rb) "at 0x%"PRIx64" in %s"
265
266get_mem_fault_cpu_index(int cpu, uint32_t pid) "cpu: %d, pid: %u"
267
268# exec.c
269migration_exec_outgoing(const char *cmd) "cmd=%s"
270migration_exec_incoming(const char *cmd) "cmd=%s"
271
272# fd.c
273migration_fd_outgoing(int fd) "fd=%d"
274migration_fd_incoming(int fd) "fd=%d"
275
276# socket.c
277migration_socket_incoming_accepted(void) ""
278migration_socket_outgoing_connected(const char *hostname) "hostname=%s"
279migration_socket_outgoing_error(const char *err) "error=%s"
280
281# tls.c
282migration_tls_outgoing_handshake_start(const char *hostname) "hostname=%s"
283migration_tls_outgoing_handshake_error(const char *err) "err=%s"
284migration_tls_outgoing_handshake_complete(void) ""
285migration_tls_incoming_handshake_start(void) ""
286migration_tls_incoming_handshake_error(const char *err) "err=%s"
287migration_tls_incoming_handshake_complete(void) ""
288
289# colo.c
290colo_vm_state_change(const char *old, const char *new) "Change '%s' => '%s'"
291colo_send_message(const char *msg) "Send '%s' message"
292colo_receive_message(const char *msg) "Receive '%s' message"
293
294# colo-failover.c
295colo_failover_set_state(const char *new_state) "new state %s"
296
297# block-dirty-bitmap.c
298send_bitmap_header_enter(void) ""
299send_bitmap_bits(uint32_t flags, uint64_t start_sector, uint32_t nr_sectors, uint64_t data_size) "flags: 0x%x, start_sector: %" PRIu64 ", nr_sectors: %" PRIu32 ", data_size: %" PRIu64
300dirty_bitmap_save_iterate(int in_postcopy) "in postcopy: %d"
301dirty_bitmap_save_complete_enter(void) ""
302dirty_bitmap_save_complete_finish(void) ""
303dirty_bitmap_save_pending(uint64_t pending, uint64_t max_size) "pending %" PRIu64 " max: %" PRIu64
304dirty_bitmap_load_complete(void) ""
305dirty_bitmap_load_bits_enter(uint64_t first_sector, uint32_t nr_sectors) "chunk: %" PRIu64 " %" PRIu32
306dirty_bitmap_load_bits_zeroes(void) ""
307dirty_bitmap_load_header(uint32_t flags) "flags 0x%x"
308dirty_bitmap_load_enter(void) ""
309dirty_bitmap_load_success(void) ""
310