X-Git-Url: https://bilbo.iut-bm.univ-fcomte.fr/and/gitweb/loba.git/blobdiff_plain/6c5ce85989b0976bbd0a663344cc270433ec1b28..9dc2c85bc1ed02f05598db7a816552c65501cf47:/main.cpp?ds=inline diff --git a/main.cpp b/main.cpp index 401a51a..ff1fa1b 100644 --- a/main.cpp +++ b/main.cpp @@ -3,13 +3,6 @@ #include #include #include -#include "deployment.h" -#include "hostdata.h" -#include "misc.h" -#include "options.h" -#include "process.h" -#include "timer.h" -#include "version.h" // Creates log categories XBT_LOG_NEW_CATEGORY(simu, "Root of simulation messages"); @@ -18,33 +11,131 @@ XBT_LOG_NEW_SUBCATEGORY(depl, main, "Messages from auto deployment"); XBT_LOG_NEW_SUBCATEGORY(comm, simu, "Messages from asynchronous pipes"); XBT_LOG_NEW_SUBCATEGORY(proc, simu, "Messages from base process class"); XBT_LOG_NEW_SUBCATEGORY(loba, simu, "Messages from load-balancer"); +XBT_LOG_NEW_SUBCATEGORY(thrd, simu, "Messages from thread wrapper class"); XBT_LOG_EXTERNAL_DEFAULT_CATEGORY(main); -// Failure exit status -enum { - EXIT_NO_FAILURE = 0x00, // no error - EXIT_FAILURE_ARGS = 0x01, // bad arguments - EXIT_FAILURE_INIT = 0x02, // failed to initialize simulator - EXIT_FAILURE_SIMU = 0x04, // simulation failed - EXIT_FAILURE_CLEAN = 0x08, // error at cleanup -}; +#include "deployment.h" +#include "hostdata.h" +#include "misc.h" +#include "options.h" +#include "process.h" +#include "statistics.h" +#include "synchro.h" +#include "timer.h" +#include "tracing.h" +#include "version.h" + +#define DATA_DESCR_WIDTH 37 + +namespace { + // Failure exit status + enum { + EXIT_NO_FAILURE = 0x00, // no error + EXIT_FAILURE_ARGS = 0x01, // bad arguments + EXIT_FAILURE_INIT = 0x02, // failed to initialize simulator + EXIT_FAILURE_SIMU = 0x04, // simulation failed + EXIT_FAILURE_CLEAN = 0x08, // error at cleanup + }; + + // Cannot be globally initialized... + mutex_t* proc_mutex; + condition_t* proc_cond; + unsigned proc_counter = 0; + + statistics loads; + statistics comps; + statistics data_send_amount; + statistics data_recv_amount; + statistics data_send_count; + statistics data_recv_count; + statistics ctrl_send_amount; + statistics ctrl_recv_amount; + statistics ctrl_send_count; + statistics ctrl_recv_count; + +} -int simulation_main(int argc, char* argv[]) +static int simulation_main(int argc, char* argv[]) { int result; process* proc; try { proc = opt::loba_algorithms.new_instance(opt::loba_algo, argc, argv); + + proc_mutex->acquire(); + ++proc_counter; + proc_mutex->release(); + result = proc->run(); + + proc_mutex->acquire(); + loads.push(proc->get_real_load()); + comps.push(proc->get_comp_amount()); + data_send_amount.push(proc->get_data_send_amount()); + data_recv_amount.push(proc->get_data_recv_amount()); + data_send_count.push(proc->get_data_send_count()); + data_recv_count.push(proc->get_data_recv_count()); + ctrl_send_amount.push(proc->get_ctrl_send_amount()); + ctrl_recv_amount.push(proc->get_ctrl_recv_amount()); + ctrl_send_count.push(proc->get_ctrl_send_count()); + ctrl_recv_count.push(proc->get_ctrl_recv_count()); + + // Synchronization barrier... + // The goal is to circumvent a limitation in SimGrid (at least + // in version 3.5): a process must be alive when another one + // destroys a communication they had together. + + --proc_counter; + proc_cond->broadcast(); + while (proc_counter > 0) + proc_cond->wait(*proc_mutex); + proc_mutex->release(); + delete proc; } - catch (std::invalid_argument& e) { + catch (const std::invalid_argument& e) { THROW1(arg_error, 0, "%s", e.what()); } + catch (const std::exception& e) { + THROW1(0, 0, "%s", e.what()); + } return result; } +static void check_for_lost_load() +{ + double total_init = process::get_total_load_init(); + double total_exit = process::get_total_load_exit(); + double lost = total_init - total_exit; + double lost_ratio = 100.0 * lost / total_init; + if (lost_ratio < -opt::load_ratio_threshold) + XBT_ERROR("Gained load at exit! %g (%g%%) <============", + -lost, -lost_ratio); + else if (lost_ratio > opt::load_ratio_threshold) + XBT_ERROR("Lost load at exit! %g (%g%%) <============", + lost, lost_ratio); + else + XBT_VERB("Total load at exit looks good: %g (%g%%)", lost, lost_ratio); + + double total_running = process::get_total_load_running(); + double running_ratio = 100.0 * total_running / total_init; + if (running_ratio < -opt::load_ratio_threshold) + XBT_ERROR("Negative running load at exit! %g (%g%%) <============", + total_running, running_ratio); + else if (running_ratio > opt::load_ratio_threshold) + XBT_ERROR("Remaining running load at exit! %g (%g%%) <============", + total_running, running_ratio); + else + XBT_VERB("Running load at exit looks good: %g (%g%%)", + total_running, running_ratio); +} + +#define PR_STATS(descr, st) \ + XBT_INFO("| %.*s: %g / %g / %g", DATA_DESCR_WIDTH, \ + descr " (total/avg./stddev)................................", \ + st.get_sum(), st.get_mean(), st.get_stddev()) + int main(int argc, char* argv[]) { // Note: variables used after THROW must be declared as volatile. @@ -57,9 +148,15 @@ int main(int argc, char* argv[]) simulation_time.start(); // Set default logging parameters - // xbt_log_control_set("simu.thres:verbose"); - xbt_log_control_set("simu.fmt:'[%h %r] [%c/%p] %m%n'"); - xbt_log_control_set("main.fmt:'[%c/%p] %m%n'"); + bool do_log_control_set = true; + for (int i = 1 ; do_log_control_set && i < argc ; i++) + do_log_control_set = !(argv[i][0] == '-' && argv[i][1] != '-' && + strchr(argv[i] + 1, 'v')); + if (do_log_control_set) { + // xbt_log_control_set("simu.thres:verbose"); + xbt_log_control_set("simu.fmt:'[%h %r] [%c/%p] %m%n'"); + xbt_log_control_set("main.fmt:'[%c/%p] %m%n'"); + } // Initialize some MSG internal data. // Note: MSG_global_init() may throw an exception, but it seems @@ -67,7 +164,7 @@ int main(int argc, char* argv[]) MSG_global_init(&argc, argv); // Parse global parameters - int parse_res = opt::parse_args(&argc, argv); + bool parse_res = opt::parse_args(&argc, argv); if (!parse_res || opt::version_requested || opt::help_requested) { if (opt::version_requested) @@ -80,7 +177,8 @@ int main(int argc, char* argv[]) MSG_clean(); exit(parse_res ? EXIT_NO_FAILURE : EXIT_FAILURE_ARGS); } - INFO3("%s v%s (%s)", opt::program_name.c_str(), version::num.c_str(), version::date.c_str()); + XBT_INFO("%s v%s (%s)", opt::program_name.c_str(), version::num.c_str(), + version::date.c_str()); opt::print(); TRY { @@ -91,14 +189,17 @@ int main(int argc, char* argv[]) MSG_function_register_default(simulation_main); // Create the platform and the application. + XBT_DEBUG("Loading platform file..."); MSG_create_environment(opt::platform_file.c_str()); + XBT_DEBUG("Creating hostdata..."); hostdata::create(); + XBT_DEBUG("Deploying processes..."); if (opt::auto_depl::enabled) { if (!opt::auto_depl::nhosts) opt::auto_depl::nhosts = hostdata::size(); if (opt::auto_depl::nhosts > hostdata::size()) { - WARN2("%u hosts is too much: limiting to %u", - opt::auto_depl::nhosts, (unsigned )hostdata::size()); + XBT_WARN("%u hosts is too much: limiting to %zu", + opt::auto_depl::nhosts, hostdata::size()); opt::auto_depl::nhosts = hostdata::size(); } if (!opt::auto_depl::load) @@ -108,13 +209,25 @@ int main(int argc, char* argv[]) MSG_launch_application(opt::deployment_file.c_str()); } + // Register tracing categories + TRACE_category(TRACE_CAT_COMP); + TRACE_category(TRACE_CAT_CTRL); + TRACE_category(TRACE_CAT_DATA); + exit_status = EXIT_FAILURE_SIMU; // ===== + proc_mutex = new mutex_t(); + proc_cond = new condition_t(); + // Launch the MSG simulation. - INFO1("Starting simulation at %f...", MSG_get_clock()); + XBT_INFO("Starting simulation at %f...", MSG_get_clock()); res = MSG_main(); - INFO1("Simulation ended at %f.", MSG_get_clock()); simulated_time = MSG_get_clock(); + XBT_INFO("Simulation ended at %f.", simulated_time); + + delete proc_cond; + delete proc_mutex; + if (res != MSG_OK) THROW1(0, 0, "MSG_main() failed with status %#x", res); @@ -124,8 +237,8 @@ int main(int argc, char* argv[]) int len = strlen(ex.msg); if (len > 0 && ex.msg[len - 1] == '\n') ex.msg[len - 1] = '\0'; // strip the ending '\n' - ERROR1("%s", ex.msg); - DEBUG3("Error from %s() in %s:%d", ex.func, ex.file, ex.line); + XBT_ERROR("%s", ex.msg); + XBT_DEBUG("Error from %s() in %s:%d", ex.func, ex.file, ex.line); xbt_ex_free(ex); } @@ -133,22 +246,37 @@ int main(int argc, char* argv[]) hostdata::destroy(); res = MSG_clean(); if (res != MSG_OK) { - ERROR1("MSG_clean() failed with status %#x", res); + XBT_ERROR("MSG_clean() failed with status %#x", res); exit_status |= EXIT_FAILURE_CLEAN; } // Report final simulation status. if (simulated_time >= 0.0) { simulation_time.stop(); - INFO0(",----[ Results ]"); - INFO1("| Total simulated time...: %g", simulated_time); - INFO1("| Total simulation time..: %g", simulation_time.duration()); - INFO0("`----"); + check_for_lost_load(); + XBT_INFO(",----[ Results ]"); + PR_STATS("Load", loads); + PR_STATS("Computation", comps); + PR_STATS("Data send amount", data_send_amount); + PR_STATS("Data recv amount", data_recv_amount); + PR_STATS("Data send count", data_send_count); + PR_STATS("Data recv count", data_recv_count); + PR_STATS("Ctrl send amount", ctrl_send_amount); + PR_STATS("Ctrl recv amount", ctrl_recv_amount); + PR_STATS("Ctrl send count", ctrl_send_count); + PR_STATS("Ctrl recv count", ctrl_recv_count); + XBT_INFO("| %.*s: %g", DATA_DESCR_WIDTH, + "Total simulated time..................................", + simulated_time); + XBT_INFO("| %.*s: %g", DATA_DESCR_WIDTH, + "Total simulation time.................................", + simulation_time.duration()); + XBT_INFO("`----"); } if (exit_status) - ERROR1("Simulation failed (%#x).", exit_status); + XBT_ERROR("Simulation failed (%#x).", exit_status); else - INFO0("Simulation succeeded."); + XBT_INFO("Simulation succeeded."); return exit_status; }