2 * BabelTrace - Common Trace Format (CTF)
4 * CTF Text Format registration.
6 * Copyright 2010-2011 EfficiOS Inc. and Linux Foundation
8 * Author: Mathieu Desnoyers <mathieu.desnoyers@efficios.com>
10 * Permission is hereby granted, free of charge, to any person obtaining a copy
11 * of this software and associated documentation files (the "Software"), to deal
12 * in the Software without restriction, including without limitation the rights
13 * to use, copy, modify, merge, publish, distribute, sublicense, and/or sell
14 * copies of the Software, and to permit persons to whom the Software is
15 * furnished to do so, subject to the following conditions:
17 * The above copyright notice and this permission notice shall be included in
18 * all copies or substantial portions of the Software.
21 #include <babeltrace/format.h>
22 #include <babeltrace/ctf-text/types.h>
23 #include <babeltrace/ctf/metadata.h>
24 #include <babeltrace/babeltrace-internal.h>
25 #include <babeltrace/ctf/events-internal.h>
29 #include <sys/types.h>
37 #define NSEC_PER_SEC 1000000000ULL
39 int opt_all_field_names
,
40 opt_scope_field_names
,
41 opt_header_field_names
,
42 opt_context_field_names
,
43 opt_payload_field_names
,
46 opt_trace_domain_field
,
47 opt_trace_procname_field
,
49 opt_trace_hostname_field
,
50 opt_trace_default_fields
= 1,
64 BT_LOGLEVEL_EMERG
= 0,
65 BT_LOGLEVEL_ALERT
= 1,
68 BT_LOGLEVEL_WARNING
= 4,
69 BT_LOGLEVEL_NOTICE
= 5,
71 BT_LOGLEVEL_DEBUG_SYSTEM
= 7,
72 BT_LOGLEVEL_DEBUG_PROGRAM
= 8,
73 BT_LOGLEVEL_DEBUG_PROCESS
= 9,
74 BT_LOGLEVEL_DEBUG_MODULE
= 10,
75 BT_LOGLEVEL_DEBUG_UNIT
= 11,
76 BT_LOGLEVEL_DEBUG_FUNCTION
= 12,
77 BT_LOGLEVEL_DEBUG_LINE
= 13,
78 BT_LOGLEVEL_DEBUG
= 14,
82 struct trace_descriptor
*ctf_text_open_trace(const char *path
, int flags
,
83 void (*packet_seek
)(struct stream_pos
*pos
, size_t index
,
84 int whence
), FILE *metadata_fp
);
86 int ctf_text_close_trace(struct trace_descriptor
*descriptor
);
89 rw_dispatch write_dispatch_table
[] = {
90 [ CTF_TYPE_INTEGER
] = ctf_text_integer_write
,
91 [ CTF_TYPE_FLOAT
] = ctf_text_float_write
,
92 [ CTF_TYPE_ENUM
] = ctf_text_enum_write
,
93 [ CTF_TYPE_STRING
] = ctf_text_string_write
,
94 [ CTF_TYPE_STRUCT
] = ctf_text_struct_write
,
95 [ CTF_TYPE_VARIANT
] = ctf_text_variant_write
,
96 [ CTF_TYPE_ARRAY
] = ctf_text_array_write
,
97 [ CTF_TYPE_SEQUENCE
] = ctf_text_sequence_write
,
101 struct format ctf_text_format
= {
102 .open_trace
= ctf_text_open_trace
,
103 .close_trace
= ctf_text_close_trace
,
106 static GQuark Q_STREAM_PACKET_CONTEXT_TIMESTAMP_BEGIN
,
107 Q_STREAM_PACKET_CONTEXT_TIMESTAMP_END
,
108 Q_STREAM_PACKET_CONTEXT_EVENTS_DISCARDED
,
109 Q_STREAM_PACKET_CONTEXT_CONTENT_SIZE
,
110 Q_STREAM_PACKET_CONTEXT_PACKET_SIZE
;
113 void __attribute__((constructor
)) init_quarks(void)
115 Q_STREAM_PACKET_CONTEXT_TIMESTAMP_BEGIN
= g_quark_from_static_string("stream.packet.context.timestamp_begin");
116 Q_STREAM_PACKET_CONTEXT_TIMESTAMP_END
= g_quark_from_static_string("stream.packet.context.timestamp_end");
117 Q_STREAM_PACKET_CONTEXT_EVENTS_DISCARDED
= g_quark_from_static_string("stream.packet.context.events_discarded");
118 Q_STREAM_PACKET_CONTEXT_CONTENT_SIZE
= g_quark_from_static_string("stream.packet.context.content_size");
119 Q_STREAM_PACKET_CONTEXT_PACKET_SIZE
= g_quark_from_static_string("stream.packet.context.packet_size");
123 struct ctf_callsite_dups
*ctf_trace_callsite_lookup(struct ctf_trace
*trace
,
124 GQuark callsite_name
)
126 return g_hash_table_lookup(trace
->callsites
,
127 (gpointer
) (unsigned long) callsite_name
);
130 int print_field(struct definition
*definition
)
132 /* Print all fields in verbose mode */
133 if (babeltrace_verbose
)
136 /* Filter out part of the packet context */
137 if (definition
->path
== Q_STREAM_PACKET_CONTEXT_TIMESTAMP_BEGIN
)
139 if (definition
->path
== Q_STREAM_PACKET_CONTEXT_TIMESTAMP_END
)
141 if (definition
->path
== Q_STREAM_PACKET_CONTEXT_EVENTS_DISCARDED
)
143 if (definition
->path
== Q_STREAM_PACKET_CONTEXT_CONTENT_SIZE
)
145 if (definition
->path
== Q_STREAM_PACKET_CONTEXT_PACKET_SIZE
)
152 void set_field_names_print(struct ctf_text_stream_pos
*pos
, enum field_item item
)
156 if (opt_all_field_names
|| opt_scope_field_names
)
157 pos
->print_names
= 1;
159 pos
->print_names
= 0;
162 if (opt_all_field_names
|| opt_header_field_names
)
163 pos
->print_names
= 1;
165 pos
->print_names
= 0;
168 if (opt_all_field_names
|| opt_context_field_names
)
169 pos
->print_names
= 1;
171 pos
->print_names
= 0;
174 if (opt_all_field_names
|| opt_payload_field_names
)
175 pos
->print_names
= 1;
177 pos
->print_names
= 0;
186 const char *print_loglevel(int value
)
191 case BT_LOGLEVEL_EMERG
:
192 return "TRACE_EMERG";
193 case BT_LOGLEVEL_ALERT
:
194 return "TRACE_ALERT";
195 case BT_LOGLEVEL_CRIT
:
197 case BT_LOGLEVEL_ERR
:
199 case BT_LOGLEVEL_WARNING
:
200 return "TRACE_WARNING";
201 case BT_LOGLEVEL_NOTICE
:
202 return "TRACE_NOTICE";
203 case BT_LOGLEVEL_INFO
:
205 case BT_LOGLEVEL_DEBUG_SYSTEM
:
206 return "TRACE_DEBUG_SYSTEM";
207 case BT_LOGLEVEL_DEBUG_PROGRAM
:
208 return "TRACE_DEBUG_PROGRAM";
209 case BT_LOGLEVEL_DEBUG_PROCESS
:
210 return "TRACE_DEBUG_PROCESS";
211 case BT_LOGLEVEL_DEBUG_MODULE
:
212 return "TRACE_DEBUG_MODULE";
213 case BT_LOGLEVEL_DEBUG_UNIT
:
214 return "TRACE_DEBUG_UNIT";
215 case BT_LOGLEVEL_DEBUG_FUNCTION
:
216 return "TRACE_DEBUG_FUNCTION";
217 case BT_LOGLEVEL_DEBUG_LINE
:
218 return "TRACE_DEBUG_LINE";
219 case BT_LOGLEVEL_DEBUG
:
220 return "TRACE_DEBUG";
222 return "<<UNKNOWN>>";
227 int ctf_text_write_event(struct stream_pos
*ppos
, struct ctf_stream_definition
*stream
)
230 struct ctf_text_stream_pos
*pos
=
231 container_of(ppos
, struct ctf_text_stream_pos
, parent
);
232 struct ctf_stream_declaration
*stream_class
= stream
->stream_class
;
234 struct ctf_event_declaration
*event_class
;
235 struct ctf_event_definition
*event
;
240 id
= stream
->event_id
;
242 if (id
>= stream_class
->events_by_id
->len
) {
243 fprintf(stderr
, "[error] Event id %" PRIu64
" is outside range.\n", id
);
246 event
= g_ptr_array_index(stream
->events_by_id
, id
);
248 fprintf(stderr
, "[error] Event id %" PRIu64
" is unknown.\n", id
);
251 event_class
= g_ptr_array_index(stream_class
->events_by_id
, id
);
253 fprintf(stderr
, "[error] Event class id %" PRIu64
" is unknown.\n", id
);
257 /* Print events discarded */
258 if (stream
->events_discarded
) {
260 fprintf(stderr
, "[warning] Tracer discarded %" PRIu64
" events between [",
261 stream
->events_discarded
);
262 if (opt_clock_cycles
) {
263 ctf_print_timestamp(stderr
, stream
,
264 stream
->prev_cycles_timestamp
);
265 fprintf(stderr
, "] and [");
266 ctf_print_timestamp(stderr
, stream
,
267 stream
->prev_cycles_timestamp_end
);
269 ctf_print_timestamp(stderr
, stream
,
270 stream
->prev_real_timestamp
);
271 fprintf(stderr
, "] and [");
272 ctf_print_timestamp(stderr
, stream
,
273 stream
->prev_real_timestamp_end
);
275 fprintf(stderr
, "]. You should consider recording a new trace with larger buffers or with fewer events enabled.\n");
277 stream
->events_discarded
= 0;
280 if (stream
->has_timestamp
) {
281 set_field_names_print(pos
, ITEM_HEADER
);
282 if (pos
->print_names
)
283 fprintf(pos
->fp
, "timestamp = ");
285 fprintf(pos
->fp
, "[");
286 if (opt_clock_cycles
) {
287 ctf_print_timestamp(pos
->fp
, stream
, stream
->cycles_timestamp
);
289 ctf_print_timestamp(pos
->fp
, stream
, stream
->real_timestamp
);
291 if (!pos
->print_names
)
292 fprintf(pos
->fp
, "]");
294 if (pos
->print_names
)
295 fprintf(pos
->fp
, ", ");
297 fprintf(pos
->fp
, " ");
299 if ((opt_delta_field
|| opt_all_fields
) && stream
->has_timestamp
) {
300 uint64_t delta
, delta_sec
, delta_nsec
;
302 set_field_names_print(pos
, ITEM_HEADER
);
303 if (pos
->print_names
)
304 fprintf(pos
->fp
, "delta = ");
306 fprintf(pos
->fp
, "(");
307 if (pos
->last_real_timestamp
!= -1ULL) {
308 delta
= stream
->real_timestamp
- pos
->last_real_timestamp
;
309 delta_sec
= delta
/ NSEC_PER_SEC
;
310 delta_nsec
= delta
% NSEC_PER_SEC
;
311 fprintf(pos
->fp
, "+%" PRIu64
".%09" PRIu64
,
312 delta_sec
, delta_nsec
);
314 fprintf(pos
->fp
, "+?.?????????");
316 if (!pos
->print_names
)
317 fprintf(pos
->fp
, ")");
319 if (pos
->print_names
)
320 fprintf(pos
->fp
, ", ");
322 fprintf(pos
->fp
, " ");
323 pos
->last_real_timestamp
= stream
->real_timestamp
;
324 pos
->last_cycles_timestamp
= stream
->cycles_timestamp
;
327 if ((opt_trace_field
|| opt_all_fields
) && stream_class
->trace
->path
[0] != '\0') {
328 set_field_names_print(pos
, ITEM_HEADER
);
329 if (pos
->print_names
) {
330 fprintf(pos
->fp
, "trace = ");
332 fprintf(pos
->fp
, "%s", stream_class
->trace
->path
);
333 if (pos
->print_names
)
334 fprintf(pos
->fp
, ", ");
336 fprintf(pos
->fp
, " ");
338 if ((opt_trace_hostname_field
|| opt_all_fields
|| opt_trace_default_fields
)
339 && stream_class
->trace
->env
.hostname
[0] != '\0') {
340 set_field_names_print(pos
, ITEM_HEADER
);
341 if (pos
->print_names
) {
342 fprintf(pos
->fp
, "trace:hostname = ");
344 fprintf(pos
->fp
, "%s", stream_class
->trace
->env
.hostname
);
345 if (pos
->print_names
)
346 fprintf(pos
->fp
, ", ");
349 if ((opt_trace_domain_field
|| opt_all_fields
) && stream_class
->trace
->env
.domain
[0] != '\0') {
350 set_field_names_print(pos
, ITEM_HEADER
);
351 if (pos
->print_names
) {
352 fprintf(pos
->fp
, "trace:domain = ");
354 fprintf(pos
->fp
, "%s", stream_class
->trace
->env
.domain
);
355 if (pos
->print_names
)
356 fprintf(pos
->fp
, ", ");
359 if ((opt_trace_procname_field
|| opt_all_fields
|| opt_trace_default_fields
)
360 && stream_class
->trace
->env
.procname
[0] != '\0') {
361 set_field_names_print(pos
, ITEM_HEADER
);
362 if (pos
->print_names
) {
363 fprintf(pos
->fp
, "trace:procname = ");
364 } else if (dom_print
) {
365 fprintf(pos
->fp
, ":");
367 fprintf(pos
->fp
, "%s", stream_class
->trace
->env
.procname
);
368 if (pos
->print_names
)
369 fprintf(pos
->fp
, ", ");
372 if ((opt_trace_vpid_field
|| opt_all_fields
|| opt_trace_default_fields
)
373 && stream_class
->trace
->env
.vpid
!= -1) {
374 set_field_names_print(pos
, ITEM_HEADER
);
375 if (pos
->print_names
) {
376 fprintf(pos
->fp
, "trace:vpid = ");
377 } else if (dom_print
) {
378 fprintf(pos
->fp
, ":");
380 fprintf(pos
->fp
, "%d", stream_class
->trace
->env
.vpid
);
381 if (pos
->print_names
)
382 fprintf(pos
->fp
, ", ");
385 if ((opt_loglevel_field
|| opt_all_fields
) && event_class
->loglevel
!= -1) {
386 set_field_names_print(pos
, ITEM_HEADER
);
387 if (pos
->print_names
) {
388 fprintf(pos
->fp
, "loglevel = ");
389 } else if (dom_print
) {
390 fprintf(pos
->fp
, ":");
392 fprintf(pos
->fp
, "%s (%d)",
393 print_loglevel(event_class
->loglevel
),
394 event_class
->loglevel
);
395 if (pos
->print_names
)
396 fprintf(pos
->fp
, ", ");
399 if ((opt_emf_field
|| opt_all_fields
) && event_class
->model_emf_uri
) {
400 set_field_names_print(pos
, ITEM_HEADER
);
401 if (pos
->print_names
) {
402 fprintf(pos
->fp
, "model.emf.uri = ");
403 } else if (dom_print
) {
404 fprintf(pos
->fp
, ":");
406 fprintf(pos
->fp
, "\"%s\"",
407 g_quark_to_string(event_class
->model_emf_uri
));
408 if (pos
->print_names
)
409 fprintf(pos
->fp
, ", ");
412 if ((opt_callsite_field
|| opt_all_fields
)) {
413 struct ctf_callsite_dups
*cs_dups
;
414 struct ctf_callsite
*callsite
;
416 cs_dups
= ctf_trace_callsite_lookup(stream_class
->trace
,
421 set_field_names_print(pos
, ITEM_HEADER
);
422 if (pos
->print_names
) {
423 fprintf(pos
->fp
, "callsite = ");
424 } else if (dom_print
) {
425 fprintf(pos
->fp
, ":");
427 fprintf(pos
->fp
, "[");
428 bt_list_for_each_entry(callsite
, &cs_dups
->head
, node
) {
430 fprintf(pos
->fp
, ",");
431 if (CTF_CALLSITE_FIELD_IS_SET(callsite
, ip
)) {
432 fprintf(pos
->fp
, "%s@0x%" PRIx64
":%s:%" PRIu64
"",
433 callsite
->func
, callsite
->ip
, callsite
->file
,
436 fprintf(pos
->fp
, "%s:%s:%" PRIu64
"",
437 callsite
->func
, callsite
->file
,
442 fprintf(pos
->fp
, "]");
443 if (pos
->print_names
)
444 fprintf(pos
->fp
, ", ");
448 if (dom_print
&& !pos
->print_names
)
449 fprintf(pos
->fp
, " ");
450 set_field_names_print(pos
, ITEM_HEADER
);
451 if (pos
->print_names
)
452 fprintf(pos
->fp
, "name = ");
453 fprintf(pos
->fp
, "%s", g_quark_to_string(event_class
->name
));
454 if (pos
->print_names
)
457 fprintf(pos
->fp
, ":");
459 /* print cpuid field from packet context */
460 if (stream
->stream_packet_context
) {
461 if (pos
->field_nr
++ != 0)
462 fprintf(pos
->fp
, ",");
463 set_field_names_print(pos
, ITEM_SCOPE
);
464 if (pos
->print_names
)
465 fprintf(pos
->fp
, " stream.packet.context =");
466 field_nr_saved
= pos
->field_nr
;
468 set_field_names_print(pos
, ITEM_CONTEXT
);
469 ret
= generic_rw(ppos
, &stream
->stream_packet_context
->p
);
472 pos
->field_nr
= field_nr_saved
;
475 /* Only show the event header in verbose mode */
476 if (babeltrace_verbose
&& stream
->stream_event_header
) {
477 if (pos
->field_nr
++ != 0)
478 fprintf(pos
->fp
, ",");
479 set_field_names_print(pos
, ITEM_SCOPE
);
480 if (pos
->print_names
)
481 fprintf(pos
->fp
, " stream.event.header =");
482 field_nr_saved
= pos
->field_nr
;
484 set_field_names_print(pos
, ITEM_CONTEXT
);
485 ret
= generic_rw(ppos
, &stream
->stream_event_header
->p
);
488 pos
->field_nr
= field_nr_saved
;
491 /* print stream-declared event context */
492 if (stream
->stream_event_context
) {
493 if (pos
->field_nr
++ != 0)
494 fprintf(pos
->fp
, ",");
495 set_field_names_print(pos
, ITEM_SCOPE
);
496 if (pos
->print_names
)
497 fprintf(pos
->fp
, " stream.event.context =");
498 field_nr_saved
= pos
->field_nr
;
500 set_field_names_print(pos
, ITEM_CONTEXT
);
501 ret
= generic_rw(ppos
, &stream
->stream_event_context
->p
);
504 pos
->field_nr
= field_nr_saved
;
507 /* print event-declared event context */
508 if (event
->event_context
) {
509 if (pos
->field_nr
++ != 0)
510 fprintf(pos
->fp
, ",");
511 set_field_names_print(pos
, ITEM_SCOPE
);
512 if (pos
->print_names
)
513 fprintf(pos
->fp
, " event.context =");
514 field_nr_saved
= pos
->field_nr
;
516 set_field_names_print(pos
, ITEM_CONTEXT
);
517 ret
= generic_rw(ppos
, &event
->event_context
->p
);
520 pos
->field_nr
= field_nr_saved
;
523 /* Read and print event payload */
524 if (event
->event_fields
) {
525 if (pos
->field_nr
++ != 0)
526 fprintf(pos
->fp
, ",");
527 set_field_names_print(pos
, ITEM_SCOPE
);
528 if (pos
->print_names
)
529 fprintf(pos
->fp
, " event.fields =");
530 field_nr_saved
= pos
->field_nr
;
532 set_field_names_print(pos
, ITEM_PAYLOAD
);
533 ret
= generic_rw(ppos
, &event
->event_fields
->p
);
536 pos
->field_nr
= field_nr_saved
;
539 fprintf(pos
->fp
, "\n");
545 fprintf(stderr
, "[error] Unexpected end of stream. Either the trace data stream is corrupted or metadata description does not match data layout.\n");
550 struct trace_descriptor
*ctf_text_open_trace(const char *path
, int flags
,
551 void (*packet_seek
)(struct stream_pos
*pos
, size_t index
,
552 int whence
), FILE *metadata_fp
)
554 struct ctf_text_stream_pos
*pos
;
557 pos
= g_new0(struct ctf_text_stream_pos
, 1);
559 pos
->last_real_timestamp
= -1ULL;
560 pos
->last_cycles_timestamp
= -1ULL;
561 switch (flags
& O_ACCMODE
) {
566 fp
= fopen(path
, "w");
570 pos
->parent
.rw_table
= write_dispatch_table
;
571 pos
->parent
.event_cb
= ctf_text_write_event
;
572 pos
->print_names
= 0;
576 fprintf(stderr
, "[error] Incorrect open flags.\n");
580 return &pos
->trace_descriptor
;
587 int ctf_text_close_trace(struct trace_descriptor
*td
)
590 struct ctf_text_stream_pos
*pos
=
591 container_of(td
, struct ctf_text_stream_pos
, trace_descriptor
);
592 ret
= fclose(pos
->fp
);
594 perror("Error on fclose");
602 void __attribute__((constructor
)) ctf_text_init(void)
606 ctf_text_format
.name
= g_quark_from_static_string("text");
607 ret
= bt_register_format(&ctf_text_format
);
612 void __attribute__((destructor
)) ctf_text_exit(void)
614 bt_unregister_format(&ctf_text_format
);