Use new defined variadic logging macros.

[loba.git] / main.cpp

diff --git a/main.cpp b/main.cpp
index df1126a9f04eccd3e465441b607690d9fe6489a9..dcefafcf3c2fdc83f8091e1a63ac38a91e34df56 100644 (file)
--- a/main.cpp
+++ b/main.cpp
@@ -1,32 +1,119 @@
-#include <cstring>              // for strlen()
+#include <cstring>

 #include <iostream>
 #include <iostream>

+#include <stdexcept>

 #include <msg/msg.h>
 #include <xbt/log.h>
 #include <msg/msg.h>
 #include <xbt/log.h>

+
+// Creates log categories
+XBT_LOG_NEW_CATEGORY(simu, "Root of simulation messages");
+XBT_LOG_NEW_SUBCATEGORY(main, simu, "Messages from global infrastructure");
+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_EXTERNAL_DEFAULT_CATEGORY(main);
+
+#include "deployment.h"
+#include "hostdata.h"

 #include "misc.h"
 #include "misc.h"

-#include "parameters.h"
+#include "options.h"

 #include "process.h"
 #include "process.h"

+#include "statistics.h"

 #include "timer.h"
 #include "timer.h"

+#include "tracing.h"

 #include "version.h"
 
 #include "version.h"
 

-// Creates a new log category and makes it the default
-XBT_LOG_NEW_DEFAULT_CATEGORY(simu, "Simulation messages");
+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
+    };
+
+    xbt_mutex_t proc_mutex;
+    xbt_cond_t proc_cond;
+    unsigned proc_counter;

 
 

-// 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
-};
+    struct statistics comps;
+    struct statistics loads;

 
 

-int simulation_main(int argc, char *argv[])
+}
+
+static int simulation_main(int argc, char* argv[])

 {
 {

-    process proc(argc, argv);
-    return proc.run();
+    int result;
+    process* proc;
+    try {
+        proc = opt::loba_algorithms.new_instance(opt::loba_algo, argc, argv);
+
+        xbt_mutex_acquire(proc_mutex);
+        ++proc_counter;
+        xbt_mutex_release(proc_mutex);
+
+        result = proc->run();
+
+        xbt_mutex_acquire(proc_mutex);
+        comps.push(proc->get_comp());
+        loads.push(proc->get_real_load());
+
+        // 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;
+        xbt_cond_broadcast(proc_cond);
+        while (proc_counter > 0)
+            xbt_cond_wait(proc_cond, proc_mutex);
+        xbt_mutex_release(proc_mutex);
+
+        delete proc;
+    }
+    catch (std::invalid_argument& e) {
+        THROW1(arg_error, 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_CRITICAL("Gained load at exit! %g (%g%%) <============",
+                     -lost, -lost_ratio);
+    else if (lost_ratio > opt::load_ratio_threshold)
+        XBT_CRITICAL("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_CRITICAL("Negative running load at exit! %g (%g%%) <============",
+                     total_running, running_ratio);
+    else if (running_ratio > opt::load_ratio_threshold)
+        XBT_CRITICAL("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);

 }
 
 }
 

-int main(int argc, char *argv[])
+#define PR_STATS(descr, st)                                             \
+    XBT_INFO("| %.*s: %g / %g / %g", 39,                                \
+             descr " total/avg./stddev. at exit.........................", \
+             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.
     volatile int exit_status = 0;   // global exit status
 {
     // Note: variables used after THROW must be declared as volatile.
     volatile int exit_status = 0;   // global exit status


@@ -37,8 +124,16 @@ int main(int argc, char *argv[])
 
     simulation_time.start();
 
 
     simulation_time.start();
 

-    // Set default logging threshold.
-    // xbt_log_control_set("simu.thres:verbose");
+    // Set default logging parameters
+    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
 
     // Initialize some MSG internal data.
     // Note: MSG_global_init() may throw an exception, but it seems


@@ -46,47 +141,68 @@ int main(int argc, char *argv[])
     MSG_global_init(&argc, argv);
 
     // Parse global parameters
     MSG_global_init(&argc, argv);
 
     // Parse global parameters

-    int parse_res = param::parse_args(&argc, argv);
+    bool parse_res = opt::parse_args(&argc, argv);

     if (!parse_res
     if (!parse_res

-        || param::version_requested || param::help_requested) {
-        if (param::version_requested)
-            std::clog << version::name << " version " << version::num << "\n"
+        || opt::version_requested || opt::help_requested) {
+        if (opt::version_requested)
+            std::clog << version::name << " (" << opt::program_name << ")"
+                      << " version " << version::num << "\n"

                       << version::copyright << "\n"
                 "Compiled on " << version::date << "\n\n";
                       << version::copyright << "\n"
                 "Compiled on " << version::date << "\n\n";

-        if (!parse_res || param::help_requested)
-            param::usage();
+        if (!parse_res || opt::help_requested)
+            opt::usage();

         MSG_clean();
         exit(parse_res ? EXIT_NO_FAILURE : EXIT_FAILURE_ARGS);
     }
         MSG_clean();
         exit(parse_res ? EXIT_NO_FAILURE : EXIT_FAILURE_ARGS);
     }

-    param::print();
+    XBT_INFO("%s v%s (%s)", opt::program_name.c_str(), version::num.c_str(),
+          version::date.c_str());
+    opt::print();

 
 

-    TRY {    
+    TRY {

         exit_status = EXIT_FAILURE_INIT; // =====
 
         exit_status = EXIT_FAILURE_INIT; // =====
 

-        // Register the main function of an agent in a global table.
-        MSG_function_register("simulation_main", simulation_main);
-        // Preserve some compatibility with old code...
-        MSG_function_register("Calculs", simulation_main);
+        // Register the default function of an agent
+        // MSG_function_register("simulation_main", simulation_main);
+        MSG_function_register_default(simulation_main);

 
         // Create the platform and the application.
 
         // Create the platform and the application.

-        MSG_create_environment(param::platform_file);
-        if (LOG_ISENABLED(xbt_log_priority_verbose)) {
-            int n = MSG_get_host_number();
-            m_host_t *h = MSG_get_host_table();
-            VERB1("Got %d hosts.", n);
-            for (int i = 0; i < n; i++)
-                VERB2("Host #%d named \"%s\".", i, MSG_host_get_name(h[i]));
-            xbt_free(h);
+        MSG_create_environment(opt::platform_file.c_str());
+        hostdata::create();
+        if (opt::auto_depl::enabled) {
+            if (!opt::auto_depl::nhosts)
+                opt::auto_depl::nhosts = hostdata::size();
+            if (opt::auto_depl::nhosts > hostdata::size()) {
+                XBT_WARN("%u hosts is too much: limiting to %u",
+                         opt::auto_depl::nhosts, (unsigned )hostdata::size());
+                opt::auto_depl::nhosts = hostdata::size();
+            }
+            if (!opt::auto_depl::load)
+                opt::auto_depl::load = opt::auto_depl::nhosts;
+            MY_launch_application(); // it is already opt::* aware...
+        } else {
+            MSG_launch_application(opt::deployment_file.c_str());

         }
         }

-        MSG_launch_application(param::application_file);
+
+        // Register tracing categories
+        TRACE_category(TRACE_CAT_COMP);
+        TRACE_category(TRACE_CAT_CTRL);
+        TRACE_category(TRACE_CAT_DATA);

 
         exit_status = EXIT_FAILURE_SIMU; // =====
 
 
         exit_status = EXIT_FAILURE_SIMU; // =====
 

+        proc_mutex = xbt_mutex_init();
+        proc_cond = xbt_cond_init();
+        proc_counter = 0;
+

         // Launch the MSG simulation.
         // Launch the MSG simulation.

-        INFO0("Starting simulation...");
+        XBT_INFO("Starting simulation at %f...", MSG_get_clock());

         res = MSG_main();
         res = MSG_main();

-        INFO0("Simulation ended.");

         simulated_time = MSG_get_clock();
         simulated_time = MSG_get_clock();

+        XBT_INFO("Simulation ended at %f.", simulated_time);
+
+        xbt_cond_destroy(proc_cond);
+        xbt_mutex_destroy(proc_mutex);
+

         if (res != MSG_OK)
             THROW1(0, 0, "MSG_main() failed with status %#x", res);
 
         if (res != MSG_OK)
             THROW1(0, 0, "MSG_main() failed with status %#x", res);
 


@@ -96,30 +212,36 @@ 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'
         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);
     }
 
     // Clean the MSG simulation.
         xbt_ex_free(ex);
     }
 
     // Clean the MSG simulation.

+    hostdata::destroy();

     res = MSG_clean();
     if (res != MSG_OK) {
     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();
         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);
+        XBT_INFO("| Total simulated time...................: %g",
+                 simulated_time);
+        XBT_INFO("| Total simulation time..................: %g",
+                 simulation_time.duration());
+        XBT_INFO("`----");

     }
     if (exit_status)
     }
     if (exit_status)

-        ERROR1("Simulation failed (%#x).", exit_status);
+        XBT_ERROR("Simulation failed (%#x).", exit_status);

     else
     else

-        INFO0("Simulation succeeded.");
+        XBT_INFO("Simulation succeeded.");

 
     return exit_status;
 }
 
     return exit_status;
 }