perf-feedback.texi 19 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370371372373374375376377378379380381382383384385386387388389390391392393394395396397398399400401402403404405406407408409410411412413414415416417418419420421422423424425426427428429430431432433434435436437438439440441442443444445446447448449450451452453454455456457458459460461462463464465466467468469470471472473474475476477478479480481482483484485486487488489490491492493494495496497498499500501502503504505506507508509510511512513514515516517518519520521522523524525526527528529530531532533534535
  1. @c -*-texinfo-*-
  2. @c This file is part of the StarPU Handbook.
  3. @c Copyright (C) 2009--2011 Universit@'e de Bordeaux 1
  4. @c Copyright (C) 2010, 2011, 2012 Centre National de la Recherche Scientifique
  5. @c Copyright (C) 2011, 2012 Institut National de Recherche en Informatique et Automatique
  6. @c See the file starpu.texi for copying conditions.
  7. @menu
  8. * On-line:: On-line performance feedback
  9. * Off-line:: Off-line performance feedback
  10. * Codelet performance:: Performance of codelets
  11. * Theoretical lower bound on execution time API::
  12. * Memory feedback::
  13. * Data statistics::
  14. @end menu
  15. @node On-line
  16. @section On-line performance feedback
  17. @menu
  18. * Enabling on-line performance monitoring::
  19. * Task feedback:: Per-task feedback
  20. * Codelet feedback:: Per-codelet feedback
  21. * Worker feedback:: Per-worker feedback
  22. * Bus feedback:: Bus-related feedback
  23. * StarPU-Top:: StarPU-Top interface
  24. @end menu
  25. @node Enabling on-line performance monitoring
  26. @subsection Enabling on-line performance monitoring
  27. In order to enable online performance monitoring, the application can call
  28. @code{starpu_profiling_status_set(STARPU_PROFILING_ENABLE)}. It is possible to
  29. detect whether monitoring is already enabled or not by calling
  30. @code{starpu_profiling_status_get()}. Enabling monitoring also reinitialize all
  31. previously collected feedback. The @code{STARPU_PROFILING} environment variable
  32. can also be set to 1 to achieve the same effect.
  33. Likewise, performance monitoring is stopped by calling
  34. @code{starpu_profiling_status_set(STARPU_PROFILING_DISABLE)}. Note that this
  35. does not reset the performance counters so that the application may consult
  36. them later on.
  37. More details about the performance monitoring API are available in section
  38. @ref{Profiling API}.
  39. @node Task feedback
  40. @subsection Per-task feedback
  41. If profiling is enabled, a pointer to a @code{starpu_task_profiling_info}
  42. structure is put in the @code{.profiling_info} field of the @code{starpu_task}
  43. structure when a task terminates.
  44. This structure is automatically destroyed when the task structure is destroyed,
  45. either automatically or by calling @code{starpu_task_destroy}.
  46. The @code{starpu_task_profiling_info} structure indicates the date when the
  47. task was submitted (@code{submit_time}), started (@code{start_time}), and
  48. terminated (@code{end_time}), relative to the initialization of
  49. StarPU with @code{starpu_init}. It also specifies the identifier of the worker
  50. that has executed the task (@code{workerid}).
  51. These date are stored as @code{timespec} structures which the user may convert
  52. into micro-seconds using the @code{starpu_timing_timespec_to_us} helper
  53. function.
  54. It it worth noting that the application may directly access this structure from
  55. the callback executed at the end of the task. The @code{starpu_task} structure
  56. associated to the callback currently being executed is indeed accessible with
  57. the @code{starpu_task_get_current()} function.
  58. @node Codelet feedback
  59. @subsection Per-codelet feedback
  60. The @code{per_worker_stats} field of the @code{struct starpu_codelet} structure is
  61. an array of counters. The i-th entry of the array is incremented every time a
  62. task implementing the codelet is executed on the i-th worker.
  63. This array is not reinitialized when profiling is enabled or disabled.
  64. @node Worker feedback
  65. @subsection Per-worker feedback
  66. The second argument returned by the @code{starpu_worker_get_profiling_info}
  67. function is a @code{starpu_worker_profiling_info} structure that gives
  68. statistics about the specified worker. This structure specifies when StarPU
  69. started collecting profiling information for that worker (@code{start_time}),
  70. the duration of the profiling measurement interval (@code{total_time}), the
  71. time spent executing kernels (@code{executing_time}), the time spent sleeping
  72. because there is no task to execute at all (@code{sleeping_time}), and the
  73. number of tasks that were executed while profiling was enabled.
  74. These values give an estimation of the proportion of time spent do real work,
  75. and the time spent either sleeping because there are not enough executable
  76. tasks or simply wasted in pure StarPU overhead.
  77. Calling @code{starpu_worker_get_profiling_info} resets the profiling
  78. information associated to a worker.
  79. When an FxT trace is generated (see @ref{Generating traces}), it is also
  80. possible to use the @code{starpu_workers_activity} script (described in @ref{starpu-workers-activity}) to
  81. generate a graphic showing the evolution of these values during the time, for
  82. the different workers.
  83. @node Bus feedback
  84. @subsection Bus-related feedback
  85. TODO: ajouter STARPU_BUS_STATS
  86. @c how to enable/disable performance monitoring
  87. @c what kind of information do we get ?
  88. The bus speed measured by StarPU can be displayed by using the
  89. @code{starpu_machine_display} tool, for instance:
  90. @example
  91. StarPU has found:
  92. 3 CUDA devices
  93. CUDA 0 (Tesla C2050 02:00.0)
  94. CUDA 1 (Tesla C2050 03:00.0)
  95. CUDA 2 (Tesla C2050 84:00.0)
  96. from to RAM to CUDA 0 to CUDA 1 to CUDA 2
  97. RAM 0.000000 5176.530428 5176.492994 5191.710722
  98. CUDA 0 4523.732446 0.000000 2414.074751 2417.379201
  99. CUDA 1 4523.718152 2414.078822 0.000000 2417.375119
  100. CUDA 2 4534.229519 2417.069025 2417.060863 0.000000
  101. @end example
  102. @node StarPU-Top
  103. @subsection StarPU-Top interface
  104. StarPU-Top is an interface which remotely displays the on-line state of a StarPU
  105. application and permits the user to change parameters on the fly.
  106. Variables to be monitored can be registered by calling the
  107. @code{starpu_top_add_data_boolean}, @code{starpu_top_add_data_integer},
  108. @code{starpu_top_add_data_float} functions, e.g.:
  109. @cartouche
  110. @smallexample
  111. starpu_top_data *data = starpu_top_add_data_integer("mynum", 0, 100, 1);
  112. @end smallexample
  113. @end cartouche
  114. The application should then call @code{starpu_top_init_and_wait} to give its name
  115. and wait for StarPU-Top to get a start request from the user. The name is used
  116. by StarPU-Top to quickly reload a previously-saved layout of parameter display.
  117. @cartouche
  118. @smallexample
  119. starpu_top_init_and_wait("the application");
  120. @end smallexample
  121. @end cartouche
  122. The new values can then be provided thanks to
  123. @code{starpu_top_update_data_boolean}, @code{starpu_top_update_data_integer},
  124. @code{starpu_top_update_data_float}, e.g.:
  125. @cartouche
  126. @smallexample
  127. starpu_top_update_data_integer(data, mynum);
  128. @end smallexample
  129. @end cartouche
  130. Updateable parameters can be registered thanks to @code{starpu_top_register_parameter_boolean}, @code{starpu_top_register_parameter_integer}, @code{starpu_top_register_parameter_float}, e.g.:
  131. @cartouche
  132. @smallexample
  133. float alpha;
  134. starpu_top_register_parameter_float("alpha", &alpha, 0, 10, modif_hook);
  135. @end smallexample
  136. @end cartouche
  137. @code{modif_hook} is a function which will be called when the parameter is being modified, it can for instance print the new value:
  138. @cartouche
  139. @smallexample
  140. void modif_hook(struct starpu_top_param *d) @{
  141. fprintf(stderr,"%s has been modified: %f\n", d->name, alpha);
  142. @}
  143. @end smallexample
  144. @end cartouche
  145. Task schedulers should notify StarPU-Top when it has decided when a task will be
  146. scheduled, so that it can show it in its Gantt chart, for instance:
  147. @cartouche
  148. @smallexample
  149. starpu_top_task_prevision(task, workerid, begin, end);
  150. @end smallexample
  151. @end cartouche
  152. Starting StarPU-Top@footnote{StarPU-Top is started via the binary
  153. @code{starpu_top}.} and the application can be done two ways:
  154. @itemize
  155. @item The application is started by hand on some machine (and thus already
  156. waiting for the start event). In the Preference dialog of StarPU-Top, the SSH
  157. checkbox should be unchecked, and the hostname and port (default is 2011) on
  158. which the application is already running should be specified. Clicking on the
  159. connection button will thus connect to the already-running application.
  160. @item StarPU-Top is started first, and clicking on the connection button will
  161. start the application itself (possibly on a remote machine). The SSH checkbox
  162. should be checked, and a command line provided, e.g.:
  163. @example
  164. ssh myserver STARPU_SCHED=heft ./application
  165. @end example
  166. If port 2011 of the remote machine can not be accessed directly, an ssh port bridge should be added:
  167. @example
  168. ssh -L 2011:localhost:2011 myserver STARPU_SCHED=heft ./application
  169. @end example
  170. and "localhost" should be used as IP Address to connect to.
  171. @end itemize
  172. @node Off-line
  173. @section Off-line performance feedback
  174. @menu
  175. * Generating traces:: Generating traces with FxT
  176. * Gantt diagram:: Creating a Gantt Diagram
  177. * DAG:: Creating a DAG with graphviz
  178. * starpu-workers-activity:: Monitoring activity
  179. @end menu
  180. @node Generating traces
  181. @subsection Generating traces with FxT
  182. StarPU can use the FxT library (see
  183. @indicateurl{https://savannah.nongnu.org/projects/fkt/}) to generate traces
  184. with a limited runtime overhead.
  185. You can either get a tarball:
  186. @example
  187. % wget http://download.savannah.gnu.org/releases/fkt/fxt-0.2.2.tar.gz
  188. @end example
  189. or use the FxT library from CVS (autotools are required):
  190. @example
  191. % cvs -d :pserver:anonymous@@cvs.sv.gnu.org:/sources/fkt co FxT
  192. % ./bootstrap
  193. @end example
  194. Compiling and installing the FxT library in the @code{$FXTDIR} path is
  195. done following the standard procedure:
  196. @example
  197. % ./configure --prefix=$FXTDIR
  198. % make
  199. % make install
  200. @end example
  201. In order to have StarPU to generate traces, StarPU should be configured with
  202. the @code{--with-fxt} option:
  203. @example
  204. $ ./configure --with-fxt=$FXTDIR
  205. @end example
  206. Or you can simply point the @code{PKG_CONFIG_PATH} to
  207. @code{$FXTDIR/lib/pkgconfig} and pass @code{--with-fxt} to @code{./configure}
  208. When FxT is enabled, a trace is generated when StarPU is terminated by calling
  209. @code{starpu_shutdown()}). The trace is a binary file whose name has the form
  210. @code{prof_file_XXX_YYY} where @code{XXX} is the user name, and
  211. @code{YYY} is the pid of the process that used StarPU. This file is saved in the
  212. @code{/tmp/} directory by default, or by the directory specified by
  213. the @code{STARPU_FXT_PREFIX} environment variable.
  214. @node Gantt diagram
  215. @subsection Creating a Gantt Diagram
  216. When the FxT trace file @code{filename} has been generated, it is possible to
  217. generate a trace in the Paje format by calling:
  218. @example
  219. % starpu_fxt_tool -i filename
  220. @end example
  221. Or alternatively, setting the @code{STARPU_GENERATE_TRACE} environment variable
  222. to 1 before application execution will make StarPU do it automatically at
  223. application shutdown.
  224. This will create a @code{paje.trace} file in the current directory that
  225. can be inspected with the @url{http://vite.gforge.inria.fr/, ViTE trace
  226. visualizing open-source tool}. It is possible to open the
  227. @code{paje.trace} file with ViTE by using the following command:
  228. @example
  229. % vite paje.trace
  230. @end example
  231. To get names of tasks instead of "unknown", fill the optional @code{name} field
  232. of the codelets, or use a performance model for them.
  233. By default, all tasks are displayed using a green color. To display tasks with
  234. varying colors, pass option @code{-c} to @code{starpu_fxt_tool}.
  235. @node DAG
  236. @subsection Creating a DAG with graphviz
  237. When the FxT trace file @code{filename} has been generated, it is possible to
  238. generate a task graph in the DOT format by calling:
  239. @example
  240. $ starpu_fxt_tool -i filename
  241. @end example
  242. This will create a @code{dag.dot} file in the current directory. This file is a
  243. task graph described using the DOT language. It is possible to get a
  244. graphical output of the graph by using the graphviz library:
  245. @example
  246. $ dot -Tpdf dag.dot -o output.pdf
  247. @end example
  248. @node starpu-workers-activity
  249. @subsection Monitoring activity
  250. When the FxT trace file @code{filename} has been generated, it is possible to
  251. generate an activity trace by calling:
  252. @example
  253. $ starpu_fxt_tool -i filename
  254. @end example
  255. This will create an @code{activity.data} file in the current
  256. directory. A profile of the application showing the activity of StarPU
  257. during the execution of the program can be generated:
  258. @example
  259. $ starpu_workers_activity activity.data
  260. @end example
  261. This will create a file named @code{activity.eps} in the current directory.
  262. This picture is composed of two parts.
  263. The first part shows the activity of the different workers. The green sections
  264. indicate which proportion of the time was spent executed kernels on the
  265. processing unit. The red sections indicate the proportion of time spent in
  266. StartPU: an important overhead may indicate that the granularity may be too
  267. low, and that bigger tasks may be appropriate to use the processing unit more
  268. efficiently. The black sections indicate that the processing unit was blocked
  269. because there was no task to process: this may indicate a lack of parallelism
  270. which may be alleviated by creating more tasks when it is possible.
  271. The second part of the @code{activity.eps} picture is a graph showing the
  272. evolution of the number of tasks available in the system during the execution.
  273. Ready tasks are shown in black, and tasks that are submitted but not
  274. schedulable yet are shown in grey.
  275. @node Codelet performance
  276. @section Performance of codelets
  277. The performance model of codelets (described in @ref{Performance model example}) can be examined by using the
  278. @code{starpu_perfmodel_display} tool:
  279. @example
  280. $ starpu_perfmodel_display -l
  281. file: <malloc_pinned.hannibal>
  282. file: <starpu_slu_lu_model_21.hannibal>
  283. file: <starpu_slu_lu_model_11.hannibal>
  284. file: <starpu_slu_lu_model_22.hannibal>
  285. file: <starpu_slu_lu_model_12.hannibal>
  286. @end example
  287. Here, the codelets of the lu example are available. We can examine the
  288. performance of the 22 kernel (in micro-seconds):
  289. @example
  290. $ starpu_perfmodel_display -s starpu_slu_lu_model_22
  291. performance model for cpu
  292. # hash size mean dev n
  293. 57618ab0 19660800 2.851069e+05 1.829369e+04 109
  294. performance model for cuda_0
  295. # hash size mean dev n
  296. 57618ab0 19660800 1.164144e+04 1.556094e+01 315
  297. performance model for cuda_1
  298. # hash size mean dev n
  299. 57618ab0 19660800 1.164271e+04 1.330628e+01 360
  300. performance model for cuda_2
  301. # hash size mean dev n
  302. 57618ab0 19660800 1.166730e+04 3.390395e+02 456
  303. @end example
  304. We can see that for the given size, over a sample of a few hundreds of
  305. execution, the GPUs are about 20 times faster than the CPUs (numbers are in
  306. us). The standard deviation is extremely low for the GPUs, and less than 10% for
  307. CPUs.
  308. The @code{starpu_regression_display} tool does the same for regression-based
  309. performance models. It also writes a @code{.gp} file in the current directory,
  310. to be run in the @code{gnuplot} tool, which shows the corresponding curve.
  311. The same can also be achieved by using StarPU's library API, see
  312. @ref{Performance Model API} and notably the @code{starpu_perfmodel_load_symbol}
  313. function. The source code of the @code{starpu_perfmodel_display} tool can be a
  314. useful example.
  315. @node Theoretical lower bound on execution time API
  316. @section Theoretical lower bound on execution time
  317. See @ref{Theoretical lower bound on execution time} for an example on how to use
  318. this API. It permits to record a trace of what tasks are needed to complete the
  319. application, and then, by using a linear system, provide a theoretical lower
  320. bound of the execution time (i.e. with an ideal scheduling).
  321. The computed bound is not really correct when not taking into account
  322. dependencies, but for an application which have enough parallelism, it is very
  323. near to the bound computed with dependencies enabled (which takes a huge lot
  324. more time to compute), and thus provides a good-enough estimation of the ideal
  325. execution time.
  326. @deftypefun void starpu_bound_start (int @var{deps}, int @var{prio})
  327. Start recording tasks (resets stats). @var{deps} tells whether
  328. dependencies should be recorded too (this is quite expensive)
  329. @end deftypefun
  330. @deftypefun void starpu_bound_stop (void)
  331. Stop recording tasks
  332. @end deftypefun
  333. @deftypefun void starpu_bound_print_dot ({FILE *}@var{output})
  334. Print the DAG that was recorded
  335. @end deftypefun
  336. @deftypefun void starpu_bound_compute ({double *}@var{res}, {double *}@var{integer_res}, int @var{integer})
  337. Get theoretical upper bound (in ms) (needs glpk support detected by @code{configure} script). It returns 0 if some performance models are not calibrated.
  338. @end deftypefun
  339. @deftypefun void starpu_bound_print_lp ({FILE *}@var{output})
  340. Emit the Linear Programming system on @var{output} for the recorded tasks, in
  341. the lp format
  342. @end deftypefun
  343. @deftypefun void starpu_bound_print_mps ({FILE *}@var{output})
  344. Emit the Linear Programming system on @var{output} for the recorded tasks, in
  345. the mps format
  346. @end deftypefun
  347. @deftypefun void starpu_bound_print ({FILE *}@var{output}, int @var{integer})
  348. Emit statistics of actual execution vs theoretical upper bound. @var{integer}
  349. permits to choose between integer solving (which takes a long time but is
  350. correct), and relaxed solving (which provides an approximate solution).
  351. @end deftypefun
  352. @node Memory feedback
  353. @section Memory feedback
  354. It is possible to enable memory statistics. To do so, you need to pass the option
  355. @code{--enable-memory-stats} when running configure. It is then
  356. possible to call the function @code{starpu_display_memory_stats()} to
  357. display statistics about the current data handles registered within StarPU.
  358. Moreover, when setting the environment variable @code{STARPU_MEMORY_STATS}, statistics will be displayed at the end
  359. of the execution on data handles which have not been cleared out.
  360. For example, if you do not unregister data at the end of the complex
  361. example, you will get something similar to:
  362. @example
  363. $ STARPU_MEMORY_STATS=1 ./examples/interface/complex
  364. ...
  365. Memory status :
  366. #-------
  367. Data on Node #3
  368. #-----
  369. Data : 0x553ff40
  370. Size : 16
  371. #--
  372. Data access stats
  373. /!\ Work Underway
  374. Node #0
  375. Direct access : 4
  376. Loaded (Owner) : 0
  377. Loaded (Shared) : 0
  378. Invalidated (was Owner) : 0
  379. Node #3
  380. Direct access : 0
  381. Loaded (Owner) : 0
  382. Loaded (Shared) : 1
  383. Invalidated (was Owner) : 0
  384. #-----
  385. Data : 0x5544710
  386. Size : 16
  387. #--
  388. Data access stats
  389. /!\ Work Underway
  390. Node #0
  391. Direct access : 2
  392. Loaded (Owner) : 0
  393. Loaded (Shared) : 1
  394. Invalidated (was Owner) : 1
  395. Node #3
  396. Direct access : 0
  397. Loaded (Owner) : 1
  398. Loaded (Shared) : 0
  399. Invalidated (was Owner) : 0
  400. @end example
  401. @node Data statistics
  402. @section Data statistics
  403. Different data statistics can be displayed at the end of the execution
  404. of the application. To enable them, you need to pass the option
  405. @code{--enable-stats} when calling @code{configure}. When calling
  406. @code{starpu_shutdown()} various statistics will be displayed,
  407. execution, MSI cache statistics, allocation cache statistics, and data
  408. transfer statistics. The display can be disabled by setting the
  409. environment variable @code{STARPU_STATS} to 0.
  410. @example
  411. $ ./examples/cholesky/cholesky_tag
  412. Computation took (in ms)
  413. 518.16
  414. Synthetic GFlops : 44.21
  415. #---------------------
  416. MSI cache stats :
  417. TOTAL MSI stats hit 1622 (66.23 %) miss 827 (33.77 %)
  418. ...
  419. @end example
  420. @example
  421. $ STARPU_STATS=0 ./examples/cholesky/cholesky_tag
  422. Computation took (in ms)
  423. 518.16
  424. Synthetic GFlops : 44.21
  425. @end example
  426. @c TODO: data transfer stats are similar to the ones displayed when
  427. @c setting STARPU_BUS_STATS