LTTng » Babeltrace

Problem description:
Watching the tracking log on another host by using lttng-relayd and babeltrace as a lttng-live viewer, during live tracing, babeltrace unexpected stops without any error reported.

How can the problem be reproduced:
First execute the following two commands on a Ubuntu host.
1). lttng-relayd -d -o /tmp/lttng/live/
2). lttng-session -d --no-kernel

Then execute the following commands on another Ubuntu host.
3). lttng-relayd -d -o /tmp/lttng/live/
4). lttng-session -d --no-kernel
5). lttng create s1 --live -U net://ip (ip: the address of the first Ubuntu host)
6). lttng enable-event -u -a
7). lttng start
8). ./hello (a test application can be found on LTTng web site: http://lttng.org/docs/#doc-tracing-your-own-user-application)

At last, observe tracking log on the first Ubuntu host.
9). babeltrace --clock-date --no-delta /tmp/lttng/live/localhost/s1-20000107-015309/

About twenty minutes, the babeltrace tracing stops without any error reported.

The debug log is as following:

[04:36:03.081401633] (+0.010076186) localhost hello_world:my_first_tracepoint: { timestamp_begin = 678972918036556, timestamp_end = 678973917652555, content_size = 20768, packet_size = 32768, events_discarded = 0, cpu_id = 0 }, { id = ( "compact" : container = 0 ), v = { compact = { timestamp = 109183534 } } }, { my_string_field = "i'm there", my_integer_field = 3 }
[debug] ctf_pos_get_event offset 20608content_size 20768
[debug] ctf_move_pos test EOF: 20608
[debug] ctf_move_pos after increment: 20608
[debug] ctf_move_pos test EOF: 20608
[debug] ctf_move_pos after increment: 20608
[debug] ctf_move_pos test EOF: 20608
[debug] ctf_move_pos after increment: 20613
[debug] ctf_move_pos test EOF: 20613
[debug] ctf_move_pos after increment: 20613
[debug] ctf_move_pos test EOF: 20613
[debug] ctf_move_pos after increment: 20613
[debug] ctf_move_pos test EOF: 20613
[debug] ctf_move_pos after increment: 20613
[debug] ctf_move_pos test EOF: 20613
[debug] ctf_move_pos after increment: 20640
[debug] ctf_move_pos test EOF: 20640
[debug] ctf_move_pos after increment: 20640
[debug] ctf_move_pos test EOF: 20640
[debug] ctf_move_pos after increment: 20640
[debug] CTF string read i'm there
[debug] ctf_move_pos test EOF: 20640
[debug] ctf_move_pos after increment: 20720
[debug] ctf_move_pos test EOF: 20720
[debug] ctf_move_pos after increment: 20736
[debug] ctf_move_pos test EOF: 20736
[debug] ctf_move_pos after increment: 20768
[04:36:03.091477819] (+0.010076186) localhost hello_world:my_first_tracepoint: { timestamp_begin = 678972918036556, timestamp_end = 678973917652555, content_size = 20768, packet_size = 32768, events_discarded = 0, cpu_id = 0 }, { id = ( "compact" : container = 0 ), v = { compact = { timestamp = 119259720 } } }, { my_string_field = "i'm there", my_integer_field = 3 }
[debug] ctf_packet_seek (before call): 20768
[debug] ctf_packet_seek (after call): -1
[verbose] finished converting. Output written to:
<stdout>