[lttng-dev] lttng trace format

[lttng-dev] lttng trace format

[Thibault, Daniel]

> Date: Thu, 20 Feb 2014 21:15:42 -0500
> From: Jessica Foest <jessica.foest@gmail.com>
>
> is there a document that explain the meaning of fields displayed in the traces generated by babeltrace ?
>
> an example :
>
> [19:52:06.617756425] *(+0.000001667)* workstation sys_splice: { cpu_id = 3
}, { perf_branches = 418157709, perf_branch_instructions = 418156946,
perf_cache_misses = 6682769, perf_cache_references = 50147680,
perf_instructions = 3049323811, vppid = 587, ppid = 587, vtid = 3502, tid =
3502, vpid = 3499, nice = 0, prio = 20, procname = "lttng-consumerd", pid =
3499 }, { fd_in = 10, off_in = 0x0, fd_out = 26, off_out = 0x0, len =
65536, flags = 5 }
>
> the field mentioned in blue , is it the execution time of sys_splice ?
>
> if yes , what's the necessity of sys_exit ?

   Nothing in blue in the digest version of your post, sadly.  If you mean the *(+0.000001667)* field, that's just the time elapsed since the previous event.

Daniel U. Thibault
Protection des syst?mes et contremesures (PSC) | Systems Protection & Countermeasures (SPC)
Cyber s?curit? pour les missions essentielles (CME) | Mission Critical Cyber Security (MCCS)
R & D pour la d?fense Canada - Valcartier (RDDC Valcartier) | Defence R&D Canada - Valcartier (DRDC Valcartier)
2459 route de la Bravoure
Qu?bec QC  G3J 1X5
CANADA
Vox : (418) 844-4000 x4245
Fax : (418) 844-4538
NAC : 918V QSDJ <http://www.travelgis.com/map.asp?addr=918V%20QSDJ>
Gouvernement du Canada | Government of Canada
<http://www.valcartier.drdc-rddc.gc.ca/>

[lttng-dev] lttng trace format

[Jessica Foest]

Hi all
is there a document that explain the meaning of fields displayed in the
traces generated by babeltrace ?


an example :

[19:52:06.617756425] *(+0.000001667)* workstation sys_splice: { cpu_id = 3
}, { perf_branches = 418157709, perf_branch_instructions = 418156946,
perf_cache_misses = 6682769, perf_cache_references = 50147680,
perf_instructions = 3049323811, vppid = 587, ppid = 587, vtid = 3502, tid =
3502, vpid = 3499, nice = 0, prio = 20, procname = "lttng-consumerd", pid =
3499 }, { fd_in = 10, off_in = 0x0, fd_out = 26, off_out = 0x0, len =
65536, flags = 5 }

the field mentioned in blue , is it the execution time of sys_splice ?

if yes , what's the necessity of sys_exit ?
Regards
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.lttng.org/pipermail/lttng-dev/attachments/20140220/4504077f/attachment.html>

[lttng-dev] lttng trace format

[Jérémie Galarneau]

On Thu, Feb 20, 2014 at 9:15 PM, Jessica Foest <jessica.foest at gmail.com> wrote:
> Hi all
> is there a document that explain the meaning of fields displayed in the
> traces generated by babeltrace ?
>
>
> an example :
>
> [19:52:06.617756425] (+0.000001667) workstation sys_splice: { cpu_id = 3 },
> { perf_branches = 418157709, perf_branch_instructions = 418156946,
> perf_cache_misses = 6682769, perf_cache_references = 50147680,
> perf_instructions = 3049323811, vppid = 587, ppid = 587, vtid = 3502, tid =
> 3502, vpid = 3499, nice = 0, prio = 20, procname = "lttng-consumerd", pid =
> 3499 }, { fd_in = 10, off_in = 0x0, fd_out = 26, off_out = 0x0, len = 65536,
> flags = 5 }
>
> the field mentioned in blue , is it the execution time of sys_splice ?
>

Hi Jessica,

It represents the delta between this event and the one before.

For instance, picking two events from a kernel trace on my system...

[21:25:29.901647477] (+0.000001585) XThink power_cpu_idle: { cpu_id =
2 }, { state = 4, cpu_id = 2 }
[21:25:29.901648940] (+0.000001463) XThink sched_stat_sleep: { cpu_id
= 6 }, { comm = "clementine", tid = 4318, delay = 5158461 }

901648940 - 901647477 = +0.000001463

Regards,
J?r?mie

> if yes , what's the necessity of sys_exit ?
> Regards
>
> _______________________________________________
> lttng-dev mailing list
> lttng-dev at lists.lttng.org
> http://lists.lttng.org/cgi-bin/mailman/listinfo/lttng-dev
>



-- 
J?r?mie Galarneau
EfficiOS Inc.
http://www.efficios.com

[lttng-dev] lttng trace format

[Jessica Foest]

Thanks a lot.


2014-02-20 21:28 GMT-05:00 J?r?mie Galarneau <jeremie.galarneau at efficios.com
>:

> On Thu, Feb 20, 2014 at 9:15 PM, Jessica Foest <jessica.foest at gmail.com>
> wrote:
> > Hi all
> > is there a document that explain the meaning of fields displayed in the
> > traces generated by babeltrace ?
> >
> >
> > an example :
> >
> > [19:52:06.617756425] (+0.000001667) workstation sys_splice: { cpu_id = 3
> },
> > { perf_branches = 418157709, perf_branch_instructions = 418156946,
> > perf_cache_misses = 6682769, perf_cache_references = 50147680,
> > perf_instructions = 3049323811, vppid = 587, ppid = 587, vtid = 3502,
> tid =
> > 3502, vpid = 3499, nice = 0, prio = 20, procname = "lttng-consumerd",
> pid =
> > 3499 }, { fd_in = 10, off_in = 0x0, fd_out = 26, off_out = 0x0, len =
> 65536,
> > flags = 5 }
> >
> > the field mentioned in blue , is it the execution time of sys_splice ?
> >
>
> Hi Jessica,
>
> It represents the delta between this event and the one before.
>
> For instance, picking two events from a kernel trace on my system...
>
> [21:25:29.901647477] (+0.000001585) XThink power_cpu_idle: { cpu_id =
> 2 }, { state = 4, cpu_id = 2 }
> [21:25:29.901648940] (+0.000001463) XThink sched_stat_sleep: { cpu_id
> = 6 }, { comm = "clementine", tid = 4318, delay = 5158461 }
>
> 901648940 - 901647477 = +0.000001463
>
> Regards,
> J?r?mie
>
> > if yes , what's the necessity of sys_exit ?
> > Regards
> >
> > _______________________________________________
> > lttng-dev mailing list
> > lttng-dev at lists.lttng.org
> > http://lists.lttng.org/cgi-bin/mailman/listinfo/lttng-dev
> >
>
>
>
> --
> J?r?mie Galarneau
> EfficiOS Inc.
> http://www.efficios.com
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.lttng.org/pipermail/lttng-dev/attachments/20140220/77e79640/attachment.html>