Document last supported kernel version for stable-2.11 branch
[lttng-modules.git] / lttng-statedump-impl.c
CommitLineData
9f36eaed
MJ
1/* SPDX-License-Identifier: (GPL-2.0 or LGPL-2.1)
2 *
886d51a3
MD
3 * lttng-statedump.c
4 *
c337ddc2
MD
5 * Linux Trace Toolkit Next Generation Kernel State Dump
6 *
7 * Copyright 2005 Jean-Hugues Deschenes <jean-hugues.deschenes@polymtl.ca>
8 * Copyright 2006-2012 Mathieu Desnoyers <mathieu.desnoyers@efficios.com>
9 *
10 * Changes:
11 * Eric Clement: Add listing of network IP interface
12 * 2006, 2007 Mathieu Desnoyers Fix kernel threads
13 * Various updates
c337ddc2
MD
14 */
15
16#include <linux/init.h>
17#include <linux/module.h>
18#include <linux/netlink.h>
19#include <linux/inet.h>
20#include <linux/ip.h>
21#include <linux/kthread.h>
22#include <linux/proc_fs.h>
23#include <linux/file.h>
24#include <linux/interrupt.h>
25#include <linux/irqnr.h>
26#include <linux/cpu.h>
27#include <linux/netdevice.h>
28#include <linux/inetdevice.h>
c337ddc2 29#include <linux/mm.h>
c337ddc2
MD
30#include <linux/swap.h>
31#include <linux/wait.h>
32#include <linux/mutex.h>
f0dbdefb 33#include <linux/device.h>
c337ddc2 34
241ae9a8
MD
35#include <lttng-events.h>
36#include <lttng-tracer.h>
37#include <wrapper/irqdesc.h>
38#include <wrapper/spinlock.h>
39#include <wrapper/fdtable.h>
241ae9a8
MD
40#include <wrapper/irq.h>
41#include <wrapper/tracepoint.h>
42#include <wrapper/genhd.h>
43#include <wrapper/file.h>
a117385f 44#include <wrapper/fdtable.h>
62c3d34c 45#include <wrapper/sched.h>
c337ddc2 46
29784493 47#ifdef CONFIG_LTTNG_HAS_LIST_IRQ
c337ddc2
MD
48#include <linux/irq.h>
49#endif
50
51/* Define the tracepoints, but do not build the probes */
52#define CREATE_TRACE_POINTS
241ae9a8 53#define TRACE_INCLUDE_PATH instrumentation/events/lttng-module
c337ddc2 54#define TRACE_INCLUDE_FILE lttng-statedump
3bc29f0a 55#define LTTNG_INSTRUMENTATION
241ae9a8 56#include <instrumentation/events/lttng-module/lttng-statedump.h>
c337ddc2 57
c6b31b34
MJ
58LTTNG_DEFINE_TRACE(lttng_statedump_block_device,
59 TP_PROTO(struct lttng_session *session,
60 dev_t dev, const char *diskname),
61 TP_ARGS(session, dev, diskname));
62
63LTTNG_DEFINE_TRACE(lttng_statedump_end,
64 TP_PROTO(struct lttng_session *session),
65 TP_ARGS(session));
66
67LTTNG_DEFINE_TRACE(lttng_statedump_interrupt,
68 TP_PROTO(struct lttng_session *session,
69 unsigned int irq, const char *chip_name,
70 struct irqaction *action),
71 TP_ARGS(session, irq, chip_name, action));
72
73LTTNG_DEFINE_TRACE(lttng_statedump_file_descriptor,
74 TP_PROTO(struct lttng_session *session,
f8922333 75 struct task_struct *p, int fd, const char *filename,
c6b31b34 76 unsigned int flags, fmode_t fmode),
f8922333 77 TP_ARGS(session, p, fd, filename, flags, fmode));
c6b31b34
MJ
78
79LTTNG_DEFINE_TRACE(lttng_statedump_start,
80 TP_PROTO(struct lttng_session *session),
81 TP_ARGS(session));
82
83LTTNG_DEFINE_TRACE(lttng_statedump_process_state,
84 TP_PROTO(struct lttng_session *session,
85 struct task_struct *p,
86 int type, int mode, int submode, int status,
f8922333
MJ
87 struct pid_namespace *pid_ns),
88 TP_ARGS(session, p, type, mode, submode, status, pid_ns));
c6b31b34
MJ
89
90LTTNG_DEFINE_TRACE(lttng_statedump_network_interface,
91 TP_PROTO(struct lttng_session *session,
92 struct net_device *dev, struct in_ifaddr *ifa),
93 TP_ARGS(session, dev, ifa));
20591cf7 94
361c023a
MD
95struct lttng_fd_ctx {
96 char *page;
97 struct lttng_session *session;
98 struct task_struct *p;
d561ecfb 99 struct files_struct *files;
361c023a
MD
100};
101
c337ddc2
MD
102/*
103 * Protected by the trace lock.
104 */
105static struct delayed_work cpu_work[NR_CPUS];
106static DECLARE_WAIT_QUEUE_HEAD(statedump_wq);
107static atomic_t kernel_threads_to_run;
108
109enum lttng_thread_type {
110 LTTNG_USER_THREAD = 0,
111 LTTNG_KERNEL_THREAD = 1,
112};
113
114enum lttng_execution_mode {
115 LTTNG_USER_MODE = 0,
116 LTTNG_SYSCALL = 1,
117 LTTNG_TRAP = 2,
118 LTTNG_IRQ = 3,
119 LTTNG_SOFTIRQ = 4,
120 LTTNG_MODE_UNKNOWN = 5,
121};
122
123enum lttng_execution_submode {
124 LTTNG_NONE = 0,
125 LTTNG_UNKNOWN = 1,
126};
127
128enum lttng_process_status {
129 LTTNG_UNNAMED = 0,
130 LTTNG_WAIT_FORK = 1,
131 LTTNG_WAIT_CPU = 2,
132 LTTNG_EXIT = 3,
133 LTTNG_ZOMBIE = 4,
134 LTTNG_WAIT = 5,
135 LTTNG_RUN = 6,
136 LTTNG_DEAD = 7,
137};
138
6bcf4dc1 139
b78104db 140#if (LTTNG_LINUX_VERSION_CODE >= LTTNG_KERNEL_VERSION(5,11,0))
6bcf4dc1
MJ
141
142#define LTTNG_PART_STRUCT_TYPE struct block_device
143
144static
145int lttng_get_part_name(struct gendisk *disk, struct block_device *part, char *name_buf)
146{
147 const char *p;
148
149 p = bdevname(part, name_buf);
150 if (!p)
151 return -ENOSYS;
152
153 return 0;
154}
155
156static
157dev_t lttng_get_part_devt(struct block_device *part)
158{
159 return part->bd_dev;
160}
161
162#else
163
164#define LTTNG_PART_STRUCT_TYPE struct hd_struct
165
166static
167int lttng_get_part_name(struct gendisk *disk, struct hd_struct *part, char *name_buf)
168{
169 const char *p;
170 struct block_device bdev;
171
172 /*
173 * Create a partial 'struct blockdevice' to use
174 * 'bdevname()' which is a simple wrapper over
175 * 'disk_name()' but has the honor to be EXPORT_SYMBOL.
176 */
177 bdev.bd_disk = disk;
178 bdev.bd_part = part;
179
180 p = bdevname(&bdev, name_buf);
181 if (!p)
182 return -ENOSYS;
183
184 return 0;
185}
186
187static
188dev_t lttng_get_part_devt(struct hd_struct *part)
189{
190 return part_devt(part);
191}
192#endif
193
7c05bae7
MJ
194#if (LTTNG_LINUX_VERSION_CODE >= LTTNG_KERNEL_VERSION(5,12,0))
195static
196int lttng_statedump_each_block_device(struct lttng_session *session, struct gendisk *disk)
197{
198 struct block_device *part;
199 unsigned long idx;
200 int ret = 0;
201
202 /* Include partition 0 */
203 idx = 0;
204
205 rcu_read_lock();
206 xa_for_each(&disk->part_tbl, idx, part) {
207 char name_buf[BDEVNAME_SIZE];
208
209 /* Exclude non-partitions bdev and empty partitions. */
210 if (bdev_is_partition(part) && !bdev_nr_sectors(part))
211 continue;
212
213 if (lttng_get_part_name(disk, part, name_buf) == -ENOSYS) {
214 ret = -ENOSYS;
215 goto end;
216 }
217 trace_lttng_statedump_block_device(session, lttng_get_part_devt(part),
218 name_buf);
219 }
220end:
221 rcu_read_unlock();
222 return ret;
223}
224#else
225static
226int lttng_statedump_each_block_device(struct lttng_session *session, struct gendisk *disk)
227{
228 struct disk_part_iter piter;
229 LTTNG_PART_STRUCT_TYPE *part;
230
231 disk_part_iter_init(&piter, disk, DISK_PITER_INCL_PART0);
232
233 while ((part = disk_part_iter_next(&piter))) {
234 char name_buf[BDEVNAME_SIZE];
235
236 if (lttng_get_part_name(disk, part, name_buf) == -ENOSYS) {
237 disk_part_iter_exit(&piter);
238 return -ENOSYS;
239 }
240 trace_lttng_statedump_block_device(session, lttng_get_part_devt(part),
241 name_buf);
242 }
243 disk_part_iter_exit(&piter);
244
245 return 0;
246}
247#endif
248
f0dbdefb
HD
249static
250int lttng_enumerate_block_devices(struct lttng_session *session)
251{
252 struct class *ptr_block_class;
253 struct device_type *ptr_disk_type;
254 struct class_dev_iter iter;
255 struct device *dev;
aeb71057 256 int ret = 0;
f0dbdefb
HD
257
258 ptr_block_class = wrapper_get_block_class();
aeb71057
MJ
259 if (!ptr_block_class) {
260 ret = -ENOSYS;
261 goto end;
262 }
f0dbdefb
HD
263 ptr_disk_type = wrapper_get_disk_type();
264 if (!ptr_disk_type) {
aeb71057
MJ
265 ret = -ENOSYS;
266 goto end;
f0dbdefb
HD
267 }
268 class_dev_iter_init(&iter, ptr_block_class, NULL, ptr_disk_type);
269 while ((dev = class_dev_iter_next(&iter))) {
f0dbdefb 270 struct gendisk *disk = dev_to_disk(dev);
f0dbdefb 271
5a91f3df
MD
272 /*
273 * Don't show empty devices or things that have been
274 * suppressed
275 */
276 if (get_capacity(disk) == 0 ||
277 (disk->flags & GENHD_FL_SUPPRESS_PARTITION_INFO))
278 continue;
279
7c05bae7 280 ret = lttng_statedump_each_block_device(session, disk);
f0dbdefb
HD
281 }
282 class_dev_iter_exit(&iter);
aeb71057
MJ
283end:
284 return ret;
f0dbdefb
HD
285}
286
c337ddc2 287#ifdef CONFIG_INET
f0dbdefb 288
c337ddc2
MD
289static
290void lttng_enumerate_device(struct lttng_session *session,
291 struct net_device *dev)
292{
293 struct in_device *in_dev;
294 struct in_ifaddr *ifa;
295
296 if (dev->flags & IFF_UP) {
297 in_dev = in_dev_get(dev);
298 if (in_dev) {
299 for (ifa = in_dev->ifa_list; ifa != NULL;
300 ifa = ifa->ifa_next) {
301 trace_lttng_statedump_network_interface(
302 session, dev, ifa);
303 }
304 in_dev_put(in_dev);
305 }
306 } else {
307 trace_lttng_statedump_network_interface(
308 session, dev, NULL);
309 }
310}
311
312static
313int lttng_enumerate_network_ip_interface(struct lttng_session *session)
314{
315 struct net_device *dev;
316
317 read_lock(&dev_base_lock);
318 for_each_netdev(&init_net, dev)
319 lttng_enumerate_device(session, dev);
320 read_unlock(&dev_base_lock);
321
322 return 0;
323}
324#else /* CONFIG_INET */
325static inline
326int lttng_enumerate_network_ip_interface(struct lttng_session *session)
327{
328 return 0;
329}
330#endif /* CONFIG_INET */
331
361c023a
MD
332static
333int lttng_dump_one_fd(const void *p, struct file *file, unsigned int fd)
334{
335 const struct lttng_fd_ctx *ctx = p;
336 const char *s = d_path(&file->f_path, ctx->page, PAGE_SIZE);
29021503 337 unsigned int flags = file->f_flags;
d561ecfb 338 struct fdtable *fdt;
361c023a 339
29021503
MD
340 /*
341 * We don't expose kernel internal flags, only userspace-visible
342 * flags.
343 */
344 flags &= ~FMODE_NONOTIFY;
d561ecfb
MD
345 fdt = files_fdtable(ctx->files);
346 /*
347 * We need to check here again whether fd is within the fdt
348 * max_fds range, because we might be seeing a different
349 * files_fdtable() than iterate_fd(), assuming only RCU is
350 * protecting the read. In reality, iterate_fd() holds
351 * file_lock, which should ensure the fdt does not change while
352 * the lock is taken, but we are not aware whether this is
353 * guaranteed or not, so play safe.
354 */
aa29f2d3 355 if (fd < fdt->max_fds && lttng_close_on_exec(fd, fdt))
29021503 356 flags |= O_CLOEXEC;
361c023a
MD
357 if (IS_ERR(s)) {
358 struct dentry *dentry = file->f_path.dentry;
359
360 /* Make sure we give at least some info */
361 spin_lock(&dentry->d_lock);
362 trace_lttng_statedump_file_descriptor(ctx->session, ctx->p, fd,
29021503 363 dentry->d_name.name, flags, file->f_mode);
361c023a
MD
364 spin_unlock(&dentry->d_lock);
365 goto end;
366 }
29021503
MD
367 trace_lttng_statedump_file_descriptor(ctx->session, ctx->p, fd, s,
368 flags, file->f_mode);
361c023a
MD
369end:
370 return 0;
371}
c337ddc2
MD
372
373static
374void lttng_enumerate_task_fd(struct lttng_session *session,
375 struct task_struct *p, char *tmp)
376{
361c023a 377 struct lttng_fd_ctx ctx = { .page = tmp, .session = session, .p = p };
d561ecfb 378 struct files_struct *files;
c337ddc2
MD
379
380 task_lock(p);
d561ecfb
MD
381 files = p->files;
382 if (!files)
383 goto end;
384 ctx.files = files;
385 lttng_iterate_fd(files, 0, lttng_dump_one_fd, &ctx);
386end:
c337ddc2
MD
387 task_unlock(p);
388}
389
390static
391int lttng_enumerate_file_descriptors(struct lttng_session *session)
392{
393 struct task_struct *p;
cfcee1c7
MD
394 char *tmp;
395
396 tmp = (char *) __get_free_page(GFP_KERNEL);
397 if (!tmp)
398 return -ENOMEM;
c337ddc2
MD
399
400 /* Enumerate active file descriptors */
401 rcu_read_lock();
402 for_each_process(p)
403 lttng_enumerate_task_fd(session, p, tmp);
404 rcu_read_unlock();
405 free_page((unsigned long) tmp);
406 return 0;
407}
408
0658bdda
MD
409#if 0
410/*
411 * FIXME: we cannot take a mmap_sem while in a RCU read-side critical section
412 * (scheduling in atomic). Normally, the tasklist lock protects this kind of
413 * iteration, but it is not exported to modules.
414 */
c337ddc2
MD
415static
416void lttng_enumerate_task_vm_maps(struct lttng_session *session,
417 struct task_struct *p)
418{
419 struct mm_struct *mm;
420 struct vm_area_struct *map;
421 unsigned long ino;
422
423 /* get_task_mm does a task_lock... */
424 mm = get_task_mm(p);
425 if (!mm)
426 return;
427
428 map = mm->mmap;
429 if (map) {
430 down_read(&mm->mmap_sem);
431 while (map) {
432 if (map->vm_file)
b06ed645 433 ino = map->vm_file->lttng_f_dentry->d_inode->i_ino;
c337ddc2
MD
434 else
435 ino = 0;
436 trace_lttng_statedump_vm_map(session, p, map, ino);
437 map = map->vm_next;
438 }
439 up_read(&mm->mmap_sem);
440 }
441 mmput(mm);
442}
443
444static
445int lttng_enumerate_vm_maps(struct lttng_session *session)
446{
447 struct task_struct *p;
448
449 rcu_read_lock();
450 for_each_process(p)
451 lttng_enumerate_task_vm_maps(session, p);
452 rcu_read_unlock();
453 return 0;
454}
0658bdda 455#endif
c337ddc2 456
29784493 457#ifdef CONFIG_LTTNG_HAS_LIST_IRQ
47faec4b 458
b78104db 459#if (LTTNG_LINUX_VERSION_CODE < LTTNG_KERNEL_VERSION(2,6,39))
47faec4b
JN
460#define irq_desc_get_chip(desc) get_irq_desc_chip(desc)
461#endif
462
c337ddc2 463static
cfcee1c7 464int lttng_list_interrupts(struct lttng_session *session)
c337ddc2
MD
465{
466 unsigned int irq;
467 unsigned long flags = 0;
468 struct irq_desc *desc;
469
470#define irq_to_desc wrapper_irq_to_desc
471 /* needs irq_desc */
472 for_each_irq_desc(irq, desc) {
473 struct irqaction *action;
474 const char *irq_chip_name =
475 irq_desc_get_chip(desc)->name ? : "unnamed_irq_chip";
476
477 local_irq_save(flags);
3a523f5b 478 wrapper_desc_spin_lock(&desc->lock);
c337ddc2
MD
479 for (action = desc->action; action; action = action->next) {
480 trace_lttng_statedump_interrupt(session,
481 irq, irq_chip_name, action);
482 }
3a523f5b 483 wrapper_desc_spin_unlock(&desc->lock);
c337ddc2
MD
484 local_irq_restore(flags);
485 }
cfcee1c7 486 return 0;
c337ddc2
MD
487#undef irq_to_desc
488}
489#else
490static inline
cfcee1c7 491int lttng_list_interrupts(struct lttng_session *session)
c337ddc2 492{
cfcee1c7 493 return 0;
c337ddc2
MD
494}
495#endif
496
4ba1f53c
MD
497/*
498 * Called with task lock held.
499 */
73e8ba37
JD
500static
501void lttng_statedump_process_ns(struct lttng_session *session,
502 struct task_struct *p,
503 enum lttng_thread_type type,
504 enum lttng_execution_mode mode,
505 enum lttng_execution_submode submode,
506 enum lttng_process_status status)
507{
73e8ba37
JD
508 struct pid_namespace *pid_ns;
509
887bcdac
MJ
510 pid_ns = task_active_pid_ns(p);
511 do {
73e8ba37 512 trace_lttng_statedump_process_state(session,
887bcdac 513 p, type, mode, submode, status, pid_ns);
d16203a5 514 pid_ns = pid_ns ? pid_ns->parent : NULL;
887bcdac 515 } while (pid_ns);
73e8ba37
JD
516}
517
c337ddc2
MD
518static
519int lttng_enumerate_process_states(struct lttng_session *session)
520{
521 struct task_struct *g, *p;
522
523 rcu_read_lock();
524 for_each_process(g) {
525 p = g;
526 do {
527 enum lttng_execution_mode mode =
528 LTTNG_MODE_UNKNOWN;
529 enum lttng_execution_submode submode =
530 LTTNG_UNKNOWN;
531 enum lttng_process_status status;
532 enum lttng_thread_type type;
533
534 task_lock(p);
535 if (p->exit_state == EXIT_ZOMBIE)
536 status = LTTNG_ZOMBIE;
537 else if (p->exit_state == EXIT_DEAD)
538 status = LTTNG_DEAD;
62c3d34c 539 else if (lttng_task_is_running(p)) {
c337ddc2
MD
540 /* Is this a forked child that has not run yet? */
541 if (list_empty(&p->rt.run_list))
542 status = LTTNG_WAIT_FORK;
543 else
544 /*
545 * All tasks are considered as wait_cpu;
546 * the viewer will sort out if the task
547 * was really running at this time.
548 */
549 status = LTTNG_WAIT_CPU;
62c3d34c 550 } else if (lttng_get_task_state(p) &
c337ddc2
MD
551 (TASK_INTERRUPTIBLE | TASK_UNINTERRUPTIBLE)) {
552 /* Task is waiting for something to complete */
553 status = LTTNG_WAIT;
554 } else
555 status = LTTNG_UNNAMED;
556 submode = LTTNG_NONE;
557
558 /*
559 * Verification of t->mm is to filter out kernel
560 * threads; Viewer will further filter out if a
561 * user-space thread was in syscall mode or not.
562 */
563 if (p->mm)
564 type = LTTNG_USER_THREAD;
565 else
566 type = LTTNG_KERNEL_THREAD;
73e8ba37 567 lttng_statedump_process_ns(session,
c337ddc2
MD
568 p, type, mode, submode, status);
569 task_unlock(p);
570 } while_each_thread(g, p);
571 }
572 rcu_read_unlock();
573
574 return 0;
575}
576
577static
578void lttng_statedump_work_func(struct work_struct *work)
579{
580 if (atomic_dec_and_test(&kernel_threads_to_run))
581 /* If we are the last thread, wake up do_lttng_statedump */
582 wake_up(&statedump_wq);
583}
584
585static
586int do_lttng_statedump(struct lttng_session *session)
587{
cfcee1c7 588 int cpu, ret;
c337ddc2 589
c337ddc2 590 trace_lttng_statedump_start(session);
cfcee1c7
MD
591 ret = lttng_enumerate_process_states(session);
592 if (ret)
593 return ret;
594 ret = lttng_enumerate_file_descriptors(session);
595 if (ret)
596 return ret;
597 /*
598 * FIXME
599 * ret = lttng_enumerate_vm_maps(session);
600 * if (ret)
601 * return ret;
602 */
603 ret = lttng_list_interrupts(session);
604 if (ret)
605 return ret;
606 ret = lttng_enumerate_network_ip_interface(session);
607 if (ret)
608 return ret;
609 ret = lttng_enumerate_block_devices(session);
610 switch (ret) {
84c7055e
MD
611 case 0:
612 break;
cfcee1c7
MD
613 case -ENOSYS:
614 printk(KERN_WARNING "LTTng: block device enumeration is not supported by kernel\n");
615 break;
616 default:
617 return ret;
618 }
c337ddc2
MD
619
620 /* TODO lttng_dump_idt_table(session); */
621 /* TODO lttng_dump_softirq_vec(session); */
622 /* TODO lttng_list_modules(session); */
623 /* TODO lttng_dump_swap_files(session); */
624
625 /*
626 * Fire off a work queue on each CPU. Their sole purpose in life
627 * is to guarantee that each CPU has been in a state where is was in
628 * syscall mode (i.e. not in a trap, an IRQ or a soft IRQ).
629 */
630 get_online_cpus();
631 atomic_set(&kernel_threads_to_run, num_online_cpus());
632 for_each_online_cpu(cpu) {
633 INIT_DELAYED_WORK(&cpu_work[cpu], lttng_statedump_work_func);
634 schedule_delayed_work_on(cpu, &cpu_work[cpu], 0);
635 }
636 /* Wait for all threads to run */
7a7128e0 637 __wait_event(statedump_wq, (atomic_read(&kernel_threads_to_run) == 0));
c337ddc2
MD
638 put_online_cpus();
639 /* Our work is done */
c337ddc2
MD
640 trace_lttng_statedump_end(session);
641 return 0;
642}
643
644/*
645 * Called with session mutex held.
646 */
647int lttng_statedump_start(struct lttng_session *session)
648{
c337ddc2
MD
649 return do_lttng_statedump(session);
650}
651EXPORT_SYMBOL_GPL(lttng_statedump_start);
652
dd8d5afb
MD
653static
654int __init lttng_statedump_init(void)
655{
d16aa9c9
MD
656 /*
657 * Allow module to load even if the fixup cannot be done. This
658 * will allow seemless transition when the underlying issue fix
659 * is merged into the Linux kernel, and when tracepoint.c
660 * "tracepoint_module_notify" is turned into a static function.
661 */
662 (void) wrapper_lttng_fixup_sig(THIS_MODULE);
663 return 0;
dd8d5afb
MD
664}
665
666module_init(lttng_statedump_init);
667
461277e7
MD
668static
669void __exit lttng_statedump_exit(void)
670{
671}
672
673module_exit(lttng_statedump_exit);
674
c337ddc2
MD
675MODULE_LICENSE("GPL and additional rights");
676MODULE_AUTHOR("Jean-Hugues Deschenes");
1c124020 677MODULE_DESCRIPTION("LTTng statedump provider");
13ab8b0a
MD
678MODULE_VERSION(__stringify(LTTNG_MODULES_MAJOR_VERSION) "."
679 __stringify(LTTNG_MODULES_MINOR_VERSION) "."
680 __stringify(LTTNG_MODULES_PATCHLEVEL_VERSION)
681 LTTNG_MODULES_EXTRAVERSION);
This page took 0.071028 seconds and 4 git commands to generate.