)]}' { "log": [ { "commit": "7e066fb870fcd1025ec3ba7bbde5d541094f4ce1", "tree": "52acda06de25c029b9834110d7bf6b4abc50353b", "parents": [ "32f85742778dfc2c74975cf0b9f5bdb13470cb32" ], "author": { "name": "Mathieu Desnoyers", "email": "mathieu.desnoyers@polymtl.ca", "time": "Fri Nov 14 17:47:47 2008 -0500" }, "committer": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Sun Nov 16 09:01:36 2008 +0100" }, "message": "tracepoints: add DECLARE_TRACE() and DEFINE_TRACE()\n\nImpact: API *CHANGE*. Must update all tracepoint users.\n\nAdd DEFINE_TRACE() to tracepoints to let them declare the tracepoint\nstructure in a single spot for all the kernel. It helps reducing memory\nconsumption, especially when declaring a lot of tracepoints, e.g. for\nkmalloc tracing.\n\n*API CHANGE WARNING*: now, DECLARE_TRACE() must be used in headers for\ntracepoint declarations rather than DEFINE_TRACE(). This is the sane way\nto do it. The name previously used was misleading.\n\nUpdates scheduler instrumentation to follow this API change.\n\nSigned-off-by: Mathieu Desnoyers \u003cmathieu.desnoyers@polymtl.ca\u003e\nSigned-off-by: Ingo Molnar \u003cmingo@elte.hu\u003e\n" }, { "commit": "74239072830ef3f1398edeb1bc1076fc330fd4a2", "tree": "60a244c6c88d9943760ded98a1a29ce018292107", "parents": [ "3f5ec13696fd4a33bde42f385406cbb1d3cc96fd" ], "author": { "name": "Frederic Weisbecker", "email": "fweisbec@gmail.com", "time": "Tue Nov 11 23:24:42 2008 +0100" }, "committer": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Wed Nov 12 10:17:19 2008 +0100" }, "message": "tracing/fastboot: Use the ring-buffer timestamp for initcall entries\n\nImpact: Split the boot tracer entries in two parts: call and return\n\nNow that we are using the sched tracer from the boot tracer, we want\nto use the same timestamp than the ring-buffer to have consistent time\ncaptures between sched events and initcall events.\n\nSo we get rid of the old time capture by the boot tracer and split the\ninitcall events in two parts: call and return. This way we have the\nring buffer timestamp of both.\n\nAn example trace:\n\n[ 27.904149584] calling net_ns_init+0x0/0x1c0 @ 1\n[ 27.904429624] initcall net_ns_init+0x0/0x1c0 returned 0 after 0 msecs\n[ 27.904575926] calling reboot_init+0x0/0x20 @ 1\n[ 27.904655399] initcall reboot_init+0x0/0x20 returned 0 after 0 msecs\n[ 27.904800228] calling sysctl_init+0x0/0x30 @ 1\n[ 27.905142914] initcall sysctl_init+0x0/0x30 returned 0 after 0 msecs\n[ 27.905287211] calling ksysfs_init+0x0/0xb0 @ 1\n ##### CPU 0 buffer started ####\n init-1 [000] 27.905395: 1:120:R + [001] 11:115:S\n ##### CPU 1 buffer started ####\n \u003cidle\u003e-0 [001] 27.905425: 0:140:R \u003d\u003d\u003e [001] 11:115:R\n init-1 [000] 27.905426: 1:120:D \u003d\u003d\u003e [000] 0:140:R\n \u003cidle\u003e-0 [000] 27.905431: 0:140:R + [000] 4:115:S\n \u003cidle\u003e-0 [000] 27.905451: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n ksoftirqd/0-4 [000] 27.905456: 4:115:S \u003d\u003d\u003e [000] 0:140:R\n udevd-11 [001] 27.905458: 11:115:R + [001] 14:115:R\n \u003cidle\u003e-0 [000] 27.905459: 0:140:R + [000] 4:115:S\n \u003cidle\u003e-0 [000] 27.905462: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n udevd-11 [001] 27.905462: 11:115:R \u003d\u003d\u003e [001] 14:115:R\n ksoftirqd/0-4 [000] 27.905467: 4:115:S \u003d\u003d\u003e [000] 0:140:R\n \u003cidle\u003e-0 [000] 27.905470: 0:140:R + [000] 4:115:S\n \u003cidle\u003e-0 [000] 27.905473: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n ksoftirqd/0-4 [000] 27.905476: 4:115:S \u003d\u003d\u003e [000] 0:140:R\n \u003cidle\u003e-0 [000] 27.905479: 0:140:R + [000] 4:115:S\n \u003cidle\u003e-0 [000] 27.905482: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n ksoftirqd/0-4 [000] 27.905486: 4:115:S \u003d\u003d\u003e [000] 0:140:R\n udevd-14 [001] 27.905499: 14:120:X \u003d\u003d\u003e [001] 11:115:R\n udevd-11 [001] 27.905506: 11:115:R + [000] 1:120:D\n \u003cidle\u003e-0 [000] 27.905515: 0:140:R \u003d\u003d\u003e [000] 1:120:R\n udevd-11 [001] 27.905517: 11:115:S \u003d\u003d\u003e [001] 0:140:R\n[ 27.905557107] initcall ksysfs_init+0x0/0xb0 returned 0 after 3906 msecs\n[ 27.905705736] calling init_jiffies_clocksource+0x0/0x10 @ 1\n[ 27.905779239] initcall init_jiffies_clocksource+0x0/0x10 returned 0 after 0 msecs\n[ 27.906769814] calling pm_init+0x0/0x30 @ 1\n[ 27.906853627] initcall pm_init+0x0/0x30 returned 0 after 0 msecs\n[ 27.906997803] calling pm_disk_init+0x0/0x20 @ 1\n[ 27.907076946] initcall pm_disk_init+0x0/0x20 returned 0 after 0 msecs\n[ 27.907222556] calling swsusp_header_init+0x0/0x30 @ 1\n[ 27.907294325] initcall swsusp_header_init+0x0/0x30 returned 0 after 0 msecs\n[ 27.907439620] calling stop_machine_init+0x0/0x50 @ 1\n init-1 [000] 27.907485: 1:120:R + [000] 2:115:S\n init-1 [000] 27.907490: 1:120:D \u003d\u003d\u003e [000] 2:115:R\n kthreadd-2 [000] 27.907507: 2:115:R + [001] 15:115:R\n \u003cidle\u003e-0 [001] 27.907517: 0:140:R \u003d\u003d\u003e [001] 15:115:R\n kthreadd-2 [000] 27.907517: 2:115:D \u003d\u003d\u003e [000] 0:140:R\n \u003cidle\u003e-0 [000] 27.907521: 0:140:R + [000] 4:115:S\n \u003cidle\u003e-0 [000] 27.907524: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n udevd-15 [001] 27.907527: 15:115:D + [000] 2:115:D\n ksoftirqd/0-4 [000] 27.907537: 4:115:S \u003d\u003d\u003e [000] 2:115:R\n udevd-15 [001] 27.907537: 15:115:D \u003d\u003d\u003e [001] 0:140:R\n kthreadd-2 [000] 27.907546: 2:115:R + [000] 1:120:D\n kthreadd-2 [000] 27.907550: 2:115:S \u003d\u003d\u003e [000] 1:120:R\n init-1 [000] 27.907584: 1:120:R + [000] 15: 0:D\n init-1 [000] 27.907589: 1:120:R + [000] 2:115:S\n init-1 [000] 27.907593: 1:120:D \u003d\u003d\u003e [000] 15: 0:R\n udevd-15 [000] 27.907601: 15: 0:S \u003d\u003d\u003e [000] 2:115:R\n ##### CPU 0 buffer started ####\n kthreadd-2 [000] 27.907616: 2:115:R + [001] 16:115:R\n ##### CPU 1 buffer started ####\n \u003cidle\u003e-0 [001] 27.907620: 0:140:R \u003d\u003d\u003e [001] 16:115:R\n kthreadd-2 [000] 27.907621: 2:115:D \u003d\u003d\u003e [000] 0:140:R\n udevd-16 [001] 27.907625: 16:115:D + [000] 2:115:D\n \u003cidle\u003e-0 [000] 27.907628: 0:140:R + [000] 4:115:S\n udevd-16 [001] 27.907629: 16:115:D \u003d\u003d\u003e [001] 0:140:R\n \u003cidle\u003e-0 [000] 27.907631: 0:140:R \u003d\u003d\u003e [000] 4:115:R\n ksoftirqd/0-4 [000] 27.907636: 4:115:S \u003d\u003d\u003e [000] 2:115:R\n kthreadd-2 [000] 27.907644: 2:115:R + [000] 1:120:D\n kthreadd-2 [000] 27.907647: 2:115:S \u003d\u003d\u003e [000] 1:120:R\n init-1 [000] 27.907657: 1:120:R + [001] 16: 0:D\n \u003cidle\u003e-0 [001] 27.907666: 0:140:R \u003d\u003d\u003e [001] 16: 0:R\n[ 27.907703862] initcall stop_machine_init+0x0/0x50 returned 0 after 0 msecs\n[ 27.907850704] calling filelock_init+0x0/0x30 @ 1\n[ 27.907926573] initcall filelock_init+0x0/0x30 returned 0 after 0 msecs\n[ 27.908071327] calling init_script_binfmt+0x0/0x10 @ 1\n[ 27.908165195] initcall init_script_binfmt+0x0/0x10 returned 0 after 0 msecs\n[ 27.908309461] calling init_elf_binfmt+0x0/0x10 @ 1\n\nSigned-off-by: Frederic Weisbecker \u003cfweisbec@gmail.com\u003e\nAcked-by: Steven Rostedt \u003crostedt@goodmis.org\u003e\nSigned-off-by: Ingo Molnar \u003cmingo@elte.hu\u003e\n" }, { "commit": "3f5ec13696fd4a33bde42f385406cbb1d3cc96fd", "tree": "3c705c5991fcf0f4968ff790bb2e2ce65c8cbf18", "parents": [ "60a011c736e7dd09a0b01ca6a051a416f3f52ffb" ], "author": { "name": "Frederic Weisbecker", "email": "fweisbec@gmail.com", "time": "Tue Nov 11 23:21:31 2008 +0100" }, "committer": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Wed Nov 12 10:17:18 2008 +0100" }, "message": "tracing/fastboot: move boot tracer structs and funcs into their own header.\n\nImpact: Cleanups on the boot tracer and ftrace\n\nThis patch bring some cleanups about the boot tracer headers. The\nfunctions and structures of this tracer have nothing related to ftrace\nand should have so their own header file.\n\nSigned-off-by: Frederic Weisbecker \u003cfweisbec@gmail.com\u003e\nAcked-by: Steven Rostedt \u003crostedt@goodmis.org\u003e\nSigned-off-by: Ingo Molnar \u003cmingo@elte.hu\u003e\n" }, { "commit": "cf569a932217b97e2fc2c48aa597fe29519a0cff", "tree": "85be252713acf89df2b63dd6f5169b7ae1b13ae2", "parents": [ "fa340d9c050e78fb21a142b617304214ae5e0c2d" ], "author": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Wed Jul 23 13:48:22 2008 +0200" }, "committer": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Tue Oct 14 10:33:14 2008 +0200" }, "message": "sched: clean up tracepoints\n\nmake it a bit more structured hence more readable.\n\nSigned-off-by: Ingo Molnar \u003cmingo@elte.hu\u003e\n" }, { "commit": "0a16b6075843325dc402edf80c1662838b929aff", "tree": "124e49d8c0196f3c6eb7aa09a7c4c3c3157fff7a", "parents": [ "4a0897526bbc5c6ac0df80b16b8c60339e717ae2" ], "author": { "name": "Mathieu Desnoyers", "email": "mathieu.desnoyers@polymtl.ca", "time": "Fri Jul 18 12:16:17 2008 -0400" }, "committer": { "name": "Ingo Molnar", "email": "mingo@elte.hu", "time": "Tue Oct 14 10:30:52 2008 +0200" }, "message": "tracing, sched: LTTng instrumentation - scheduler\n\nInstrument the scheduler activity (sched_switch, migration, wakeups,\nwait for a task, signal delivery) and process/thread\ncreation/destruction (fork, exit, kthread stop). Actually, kthread\ncreation is not instrumented in this patch because it is architecture\ndependent. It allows to connect tracers such as ftrace which detects\nscheduling latencies, good/bad scheduler decisions. Tools like LTTng can\nexport this scheduler information along with instrumentation of the rest\nof the kernel activity to perform post-mortem analysis on the scheduler\nactivity.\n\nAbout the performance impact of tracepoints (which is comparable to\nmarkers), even without immediate values optimizations, tests done by\nHideo Aoki on ia64 show no regression. His test case was using hackbench\non a kernel where scheduler instrumentation (about 5 events in code\nscheduler code) was added. See the \"Tracepoints\" patch header for\nperformance result detail.\n\nChangelog :\n\n- Change instrumentation location and parameter to match ftrace\n instrumentation, previously done with kernel markers.\n\n[ mingo@elte.hu: conflict resolutions ]\nSigned-off-by: Mathieu Desnoyers \u003cmathieu.desnoyers@polymtl.ca\u003e\nAcked-by: \u0027Peter Zijlstra\u0027 \u003cpeterz@infradead.org\u003e\nSigned-off-by: Ingo Molnar \u003cmingo@elte.hu\u003e\n" } ] }