src/smpi/smpi_bench.cpp

   1 /* Copyright (c) 2007, 2009-2017. The SimGrid Team. All rights reserved.    */
   2
   3 /* This program is free software; you can redistribute it and/or modify it
   4  * under the terms of the license (GNU LGPL) which comes with this package. */
   5
   6 #include "src/internal_config.h"
   7 #include "private.h"
   8 #include "private.hpp"
   9 #include "simgrid/modelchecker.h"
  10 #include "src/mc/mc_replay.h"
  11 #include "src/smpi/smpi_process.hpp"
  12 #include "src/smpi/smpi_comm.hpp"
  13
  14 #ifndef WIN32
  15 #include <sys/mman.h>
  16 #endif
  17 #include <math.h> // sqrt
  18
  19 #if HAVE_PAPI
  20 #include <papi.h>
  21 #endif
  22
  23 XBT_LOG_NEW_DEFAULT_SUBCATEGORY(smpi_bench, smpi, "Logging specific to SMPI (benchmarking)");
  24
  25
  26 xbt_dict_t samples = nullptr;         /* Allocated on first use */
  27
  28 double smpi_cpu_threshold = -1;
  29 double smpi_host_speed;
  30
  31 shared_malloc_type smpi_cfg_shared_malloc = shmalloc_global;
  32 double smpi_total_benched_time = 0;
  33 smpi_privatisation_region_t smpi_privatisation_regions;
  34
  35 void smpi_bench_destroy()
  36 {
  37   xbt_dict_free(&samples);
  38 }
  39
  40 extern "C" XBT_PUBLIC(void) smpi_execute_flops_(double *flops);
  41 void smpi_execute_flops_(double *flops)
  42 {
  43   smpi_execute_flops(*flops);
  44 }
  45
  46 extern "C" XBT_PUBLIC(void) smpi_execute_(double *duration);
  47 void smpi_execute_(double *duration)
  48 {
  49   smpi_execute(*duration);
  50 }
  51
  52 void smpi_execute_flops(double flops) {
  53   XBT_DEBUG("Handle real computation time: %f flops", flops);
  54   smx_activity_t action = simcall_execution_start("computation", flops, 1, 0);
  55   simcall_set_category (action, TRACE_internal_smpi_get_category());
  56   simcall_execution_wait(action);
  57   smpi_switch_data_segment(smpi_process()->index());
  58 }
  59
  60 void smpi_execute(double duration)
  61 {
  62   if (duration >= smpi_cpu_threshold) {
  63     XBT_DEBUG("Sleep for %g to handle real computation time", duration);
  64     double flops = duration * smpi_host_speed;
  65     int rank = smpi_process()->index();
  66     instr_extra_data extra = xbt_new0(s_instr_extra_data_t,1);
  67     extra->type=TRACING_COMPUTING;
  68     extra->comp_size=flops;
  69     TRACE_smpi_computing_in(rank, extra);
  70
  71     smpi_execute_flops(flops);
  72
  73     TRACE_smpi_computing_out(rank);
  74
  75   } else {
  76     XBT_DEBUG("Real computation took %g while option smpi/cpu_threshold is set to %g => ignore it", duration,
  77               smpi_cpu_threshold);
  78   }
  79 }
  80
  81 void smpi_bench_begin()
  82 {
  83   if (smpi_privatize_global_variables == SMPI_PRIVATIZE_MMAP) {
  84     smpi_switch_data_segment(smpi_process()->index());
  85   }
  86
  87   if (MC_is_active() || MC_record_replay_is_active())
  88     return;
  89
  90 #if HAVE_PAPI
  91   if (xbt_cfg_get_string("smpi/papi-events")[0] != '\0') {
  92     int event_set = smpi_process()->papi_event_set();
  93     // PAPI_start sets everything to 0! See man(3) PAPI_start
  94     if (PAPI_LOW_LEVEL_INITED == PAPI_is_initialized()) {
  95       if (PAPI_start(event_set) != PAPI_OK) {
  96         // TODO This needs some proper handling.
  97         XBT_CRITICAL("Could not start PAPI counters.\n");
  98         xbt_die("Error.");
  99       }
 100     }
 101   }
 102 #endif
 103   xbt_os_threadtimer_start(smpi_process()->timer());
 104 }
 105
 106 void smpi_bench_end()
 107 {
 108   if (MC_is_active() || MC_record_replay_is_active())
 109     return;
 110
 111   double speedup = 1;
 112   xbt_os_timer_t timer = smpi_process()->timer();
 113   xbt_os_threadtimer_stop(timer);
 114
 115 #if HAVE_PAPI
 116   /**
 117    * An MPI function has been called and now is the right time to update
 118    * our PAPI counters for this process.
 119    */
 120   if (xbt_cfg_get_string("smpi/papi-events")[0] != '\0') {
 121     papi_counter_t& counter_data        = smpi_process()->papi_counters();
 122     int event_set                       = smpi_process()->papi_event_set();
 123     std::vector<long long> event_values = std::vector<long long>(counter_data.size());
 124
 125     if (PAPI_stop(event_set, &event_values[0]) != PAPI_OK) { // Error
 126       XBT_CRITICAL("Could not stop PAPI counters.\n");
 127       xbt_die("Error.");
 128     } else {
 129       for (unsigned int i = 0; i < counter_data.size(); i++) {
 130         counter_data[i].second += event_values[i];
 131         // XBT_DEBUG("[%i] PAPI: Counter %s: Value is now %lli (got increment by %lli\n", smpi_process()->index(),
 132         // counter_data[i].first.c_str(), counter_data[i].second, event_values[i]);
 133       }
 134     }
 135   }
 136 #endif
 137
 138   if (smpi_process()->sampling()) {
 139     XBT_CRITICAL("Cannot do recursive benchmarks.");
 140     XBT_CRITICAL("Are you trying to make a call to MPI within a SMPI_SAMPLE_ block?");
 141     xbt_backtrace_display_current();
 142     xbt_die("Aborting.");
 143   }
 144
 145   if (xbt_cfg_get_string("smpi/comp-adjustment-file")[0] != '\0') { // Maybe we need to artificially speed up or slow
 146     // down our computation based on our statistical analysis.
 147
 148     smpi_trace_call_location_t* loc                            = smpi_process()->call_location();
 149     std::string key                                            = loc->get_composed_key();
 150     std::unordered_map<std::string, double>::const_iterator it = location2speedup.find(key);
 151     if (it != location2speedup.end()) {
 152       speedup = it->second;
 153     }
 154   }
 155
 156   // Simulate the benchmarked computation unless disabled via command-line argument
 157   if (xbt_cfg_get_boolean("smpi/simulate-computation")) {
 158     smpi_execute(xbt_os_timer_elapsed(timer)/speedup);
 159   }
 160
 161 #if HAVE_PAPI
 162   if (xbt_cfg_get_string("smpi/papi-events")[0] != '\0' && TRACE_smpi_is_enabled()) {
 163     char container_name[INSTR_DEFAULT_STR_SIZE];
 164     smpi_container(smpi_process()->index(), container_name, INSTR_DEFAULT_STR_SIZE);
 165     container_t container        = PJ_container_get(container_name);
 166     papi_counter_t& counter_data = smpi_process()->papi_counters();
 167
 168     for (auto& pair : counter_data) {
 169       new_pajeSetVariable(surf_get_clock(), container,
 170                           PJ_type_get(/* countername */ pair.first.c_str(), container->type), pair.second);
 171     }
 172   }
 173 #endif
 174
 175   smpi_total_benched_time += xbt_os_timer_elapsed(timer);
 176 }
 177
 178 /* Private sleep function used by smpi_sleep() and smpi_usleep() */
 179 static unsigned int private_sleep(double secs)
 180 {
 181   smpi_bench_end();
 182
 183   XBT_DEBUG("Sleep for: %lf secs", secs);
 184   int rank = MPI_COMM_WORLD->rank();
 185   instr_extra_data extra = xbt_new0(s_instr_extra_data_t,1);
 186   extra->type=TRACING_SLEEPING;
 187   extra->sleep_duration=secs;
 188   TRACE_smpi_sleeping_in(rank, extra);
 189
 190   simcall_process_sleep(secs);
 191
 192   TRACE_smpi_sleeping_out(rank);
 193
 194   smpi_bench_begin();
 195   return 0;
 196 }
 197
 198 unsigned int smpi_sleep(unsigned int secs)
 199 {
 200   return private_sleep(static_cast<double>(secs));
 201 }
 202
 203 int smpi_usleep(useconds_t usecs)
 204 {
 205   return static_cast<int>(private_sleep(static_cast<double>(usecs) / 1000000.0));
 206 }
 207
 208 #if _POSIX_TIMERS > 0
 209 int smpi_nanosleep(const struct timespec *tp, struct timespec * t)
 210 {
 211   return static_cast<int>(private_sleep(static_cast<double>(tp->tv_sec + tp->tv_nsec / 1000000000.0)));
 212 }
 213 #endif
 214
 215 int smpi_gettimeofday(struct timeval *tv, void* tz)
 216 {
 217   smpi_bench_end();
 218   double now = SIMIX_get_clock();
 219   if (tv) {
 220     tv->tv_sec = static_cast<time_t>(now);
 221 #ifdef WIN32
 222     tv->tv_usec = static_cast<useconds_t>((now - tv->tv_sec) * 1e6);
 223 #else
 224     tv->tv_usec = static_cast<suseconds_t>((now - tv->tv_sec) * 1e6);
 225 #endif
 226   }
 227   smpi_bench_begin();
 228   return 0;
 229 }
 230
 231 #if _POSIX_TIMERS > 0
 232 int smpi_clock_gettime(clockid_t clk_id, struct timespec *tp)
 233 {
 234   //there is only one time in SMPI, so clk_id is ignored.
 235   smpi_bench_end();
 236   double now = SIMIX_get_clock();
 237   if (tp) {
 238     tp->tv_sec = static_cast<time_t>(now);
 239     tp->tv_nsec = static_cast<long int>((now - tp->tv_sec) * 1e9);
 240   }
 241   smpi_bench_begin();
 242   return 0;
 243 }
 244 #endif
 245
 246 extern double sg_surf_precision;
 247 unsigned long long smpi_rastro_resolution ()
 248 {
 249   smpi_bench_end();
 250   double resolution = (1/sg_surf_precision);
 251   smpi_bench_begin();
 252   return static_cast<unsigned long long>(resolution);
 253 }
 254
 255 unsigned long long smpi_rastro_timestamp ()
 256 {
 257   smpi_bench_end();
 258   double now = SIMIX_get_clock();
 259
 260   unsigned long long sec = static_cast<unsigned long long>(now);
 261   unsigned long long pre = (now - sec) * smpi_rastro_resolution();
 262   smpi_bench_begin();
 263   return static_cast<unsigned long long>(sec) * smpi_rastro_resolution() + pre;
 264 }
 265
 266 /* ****************************** Functions related to the SMPI_SAMPLE_ macros ************************************/
 267 typedef struct {
 268   double threshold; /* maximal stderr requested (if positive) */
 269   double relstderr; /* observed stderr so far */
 270   double mean;      /* mean of benched times, to be used if the block is disabled */
 271   double sum;       /* sum of benched times (to compute the mean and stderr) */
 272   double sum_pow2;  /* sum of the square of the benched times (to compute the stderr) */
 273   int iters;        /* amount of requested iterations */
 274   int count;        /* amount of iterations done so far */
 275   int benching;     /* 1: we are benchmarking; 0: we have enough data, no bench anymore */
 276 } local_data_t;
 277
 278 static char *sample_location(int global, const char *file, int line) {
 279   if (global) {
 280     return bprintf("%s:%d", file, line);
 281   } else {
 282     return bprintf("%s:%d:%d", file, line, smpi_process()->index());
 283   }
 284 }
 285
 286 static int sample_enough_benchs(local_data_t *data) {
 287   int res = data->count >= data->iters;
 288   if (data->threshold>0.0) {
 289     if (data->count <2)
 290       res = 0; // not enough data
 291     if (data->relstderr > data->threshold)
 292       res = 0; // stderr too high yet
 293   }
 294   XBT_DEBUG("%s (count:%d iter:%d stderr:%f thres:%f mean:%fs)",
 295       (res?"enough benchs":"need more data"), data->count, data->iters, data->relstderr, data->threshold, data->mean);
 296   return res;
 297 }
 298
 299 void smpi_sample_1(int global, const char *file, int line, int iters, double threshold)
 300 {
 301   char *loc = sample_location(global, file, line);
 302
 303   smpi_bench_end();     /* Take time from previous, unrelated computation into account */
 304   smpi_process()->set_sampling(1);
 305
 306   if (samples==nullptr)
 307     samples = xbt_dict_new_homogeneous(free);
 308
 309   local_data_t *data = static_cast<local_data_t *>(xbt_dict_get_or_null(samples, loc));
 310   if (data==nullptr) {
 311     xbt_assert(threshold>0 || iters>0,
 312         "You should provide either a positive amount of iterations to bench, or a positive maximal stderr (or both)");
 313     data = static_cast<local_data_t *>( xbt_new(local_data_t, 1));
 314     data->count = 0;
 315     data->sum = 0.0;
 316     data->sum_pow2 = 0.0;
 317     data->iters = iters;
 318     data->threshold = threshold;
 319     data->benching = 1; // If we have no data, we need at least one
 320     data->mean = 0;
 321     xbt_dict_set(samples, loc, data, nullptr);
 322     XBT_DEBUG("XXXXX First time ever on benched nest %s.",loc);
 323   } else {
 324     if (data->iters != iters || data->threshold != threshold) {
 325       XBT_ERROR("Asked to bench block %s with different settings %d, %f is not %d, %f. "
 326                 "How did you manage to give two numbers at the same line??",
 327                 loc, data->iters, data->threshold, iters, threshold);
 328       THROW_IMPOSSIBLE;
 329     }
 330
 331     // if we already have some data, check whether sample_2 should get one more bench or whether it should emulate
 332     // the computation instead
 333     data->benching = (sample_enough_benchs(data) == 0);
 334     XBT_DEBUG("XXXX Re-entering the benched nest %s. %s", loc,
 335               (data->benching ? "more benching needed" : "we have enough data, skip computes"));
 336   }
 337   xbt_free(loc);
 338 }
 339
 340 int smpi_sample_2(int global, const char *file, int line)
 341 {
 342   char *loc = sample_location(global, file, line);
 343   int res;
 344
 345   xbt_assert(samples, "Y U NO use SMPI_SAMPLE_* macros? Stop messing directly with smpi_sample_* functions!");
 346   local_data_t *data = static_cast<local_data_t *>(xbt_dict_get(samples, loc));
 347   XBT_DEBUG("sample2 %s",loc);
 348   xbt_free(loc);
 349
 350   if (data->benching==1) {
 351     // we need to run a new bench
 352     XBT_DEBUG("benchmarking: count:%d iter:%d stderr:%f thres:%f; mean:%f",
 353         data->count, data->iters, data->relstderr, data->threshold, data->mean);
 354     res = 1;
 355   } else {
 356     // Enough data, no more bench (either we got enough data from previous visits to this benched nest, or we just
 357     //ran one bench and need to bail out now that our job is done). Just sleep instead
 358     XBT_DEBUG("No benchmark (either no need, or just ran one): count >= iter (%d >= %d) or stderr<thres (%f<=%f)."
 359               " apply the %fs delay instead",
 360               data->count, data->iters, data->relstderr, data->threshold, data->mean);
 361     smpi_execute(data->mean);
 362     smpi_process()->set_sampling(0);
 363     res = 0; // prepare to capture future, unrelated computations
 364   }
 365   smpi_bench_begin();
 366   return res;
 367 }
 368
 369 void smpi_sample_3(int global, const char *file, int line)
 370 {
 371   char *loc = sample_location(global, file, line);
 372
 373   xbt_assert(samples, "Y U NO use SMPI_SAMPLE_* macros? Stop messing directly with smpi_sample_* functions!");
 374   local_data_t *data = static_cast<local_data_t *>(xbt_dict_get(samples, loc));
 375   XBT_DEBUG("sample3 %s",loc);
 376   xbt_free(loc);
 377
 378   if (data->benching==0)
 379     THROW_IMPOSSIBLE;
 380
 381   // ok, benchmarking this loop is over
 382   xbt_os_threadtimer_stop(smpi_process()->timer());
 383
 384   // update the stats
 385   data->count++;
 386   double sample = xbt_os_timer_elapsed(smpi_process()->timer());
 387   data->sum += sample;
 388   data->sum_pow2 += sample * sample;
 389   double n = static_cast<double>(data->count);
 390   data->mean = data->sum / n;
 391   data->relstderr = sqrt((data->sum_pow2 / n - data->mean * data->mean) / n) / data->mean;
 392   if (sample_enough_benchs(data)==0) {
 393     data->mean = sample; // Still in benching process; We want sample_2 to simulate the exact time of this loop
 394     // occurrence before leaving, not the mean over the history
 395   }
 396   XBT_DEBUG("Average mean after %d steps is %f, relative standard error is %f (sample was %f)", data->count,
 397       data->mean, data->relstderr, sample);
 398
 399   // That's enough for now, prevent sample_2 to run the same code over and over
 400   data->benching = 0;
 401 }
 402
 403 extern "C" { /** These functions will be called from the user code **/
 404   smpi_trace_call_location_t* smpi_trace_get_call_location() {
 405     return smpi_process()->call_location();
 406   }
 407
 408   void smpi_trace_set_call_location(const char* file, const int line) {
 409     smpi_trace_call_location_t* loc = smpi_process()->call_location();
 410
 411     loc->previous_filename   = loc->filename;
 412     loc->previous_linenumber = loc->linenumber;
 413     loc->filename            = file;
 414     loc->linenumber          = line;
 415   }
 416
 417   /**
 418    * Required for Fortran bindings
 419    */
 420   void smpi_trace_set_call_location_(const char* file, int* line) {
 421     smpi_trace_set_call_location(file, *line);
 422   }
 423
 424   /**
 425    * Required for Fortran if -fsecond-underscore is activated
 426    */
 427   void smpi_trace_set_call_location__(const char* file, int* line) {
 428     smpi_trace_set_call_location(file, *line);
 429   }
 430 }