X-Git-Url: http://info.iut-bm.univ-fcomte.fr/pub/gitweb/simgrid.git/blobdiff_plain/cdf579a58a51a10bcdc91ea8e8b92292ee7f48f8..39a84606da478fb42f8988c27ddebb5f4f5633f0:/src/instr/instr_paje_trace.cpp diff --git a/src/instr/instr_paje_trace.cpp b/src/instr/instr_paje_trace.cpp index d436124135..9c094b68bc 100644 --- a/src/instr/instr_paje_trace.cpp +++ b/src/instr/instr_paje_trace.cpp @@ -1,28 +1,85 @@ -/* Copyright (c) 2010-2016. The SimGrid Team. +/* Copyright (c) 2010-2017. The SimGrid Team. * All rights reserved. */ /* This program is free software; you can redistribute it and/or modify it * under the terms of the license (GNU LGPL) which comes with this package. */ -#include "src/instr/instr_private.h" -#include "xbt/virtu.h" /* sg_cmdline */ -#include -#include -#include /** std::setprecision **/ #include "simgrid/sg_config.h" +#include "src/instr/instr_private.hpp" +#include "src/instr/instr_smpi.hpp" +#include "src/smpi/include/private.hpp" +#include "typeinfo" +#include "xbt/virtu.h" /* sg_cmdline */ +#include -XBT_LOG_NEW_DEFAULT_SUBCATEGORY(instr_paje_trace, instr_trace, "tracing event system"); - -extern FILE * tracing_file; -extern s_instr_trace_writer_t active_writer; +XBT_LOG_NEW_DEFAULT_SUBCATEGORY(instr_paje_trace, instr, "tracing event system"); static std::stringstream stream; +FILE *tracing_file = nullptr; + +std::vector buffer; +void buffer_debug(std::vector* buf); + +void dump_comment(std::string comment) +{ + if (comment.empty()) + return; + fprintf(tracing_file, "# %s\n", comment.c_str()); +} + +void dump_comment_file(std::string filename) +{ + if (filename.empty()) + return; + std::ifstream* fs = new std::ifstream(); + fs->open(filename.c_str(), std::ifstream::in); + + if (fs->fail()) { + THROWF(system_error, 1, "Comment file %s could not be opened for reading.", filename.c_str()); + } + while (not fs->eof()) { + std::string line; + fprintf (tracing_file, "# "); + std::getline(*fs, line); + fprintf(tracing_file, "%s", line.c_str()); + } + fs->close(); +} + +double TRACE_last_timestamp_to_dump = 0; +//dumps the trace file until the timestamp TRACE_last_timestamp_to_dump +void TRACE_paje_dump_buffer(bool force) +{ + if (not TRACE_is_enabled()) + return; + XBT_DEBUG("%s: dump until %f. starts", __FUNCTION__, TRACE_last_timestamp_to_dump); + if (force){ + for (auto const& event : buffer) { + event->print(); + delete event; + } + buffer.clear(); + }else{ + std::vector::iterator i = buffer.begin(); + for (auto const& event : buffer) { + double head_timestamp = event->timestamp_; + if (head_timestamp > TRACE_last_timestamp_to_dump) + break; + event->print(); + delete event; + ++i; + } + buffer.erase(buffer.begin(), i); + } + XBT_DEBUG("%s: ends", __FUNCTION__); +} -void buffer_debug(std::vector *buf); -void buffer_debug(std::vector *buf) { - return; +void buffer_debug(std::vector* buf) +{ + if (not XBT_LOG_ISENABLED(instr_paje_trace, xbt_log_priority_debug)) + return; XBT_DEBUG(">>>>>> Dump the state of the buffer. %zu events", buf->size()); - for (auto event :*buf){ + for (auto const& event : *buf) { event->print(); XBT_DEBUG("%p %s", event, stream.str().c_str()); stream.str(""); @@ -31,28 +88,36 @@ void buffer_debug(std::vector *buf) { XBT_DEBUG("<<<<<<"); } -static void init_stream(PajeEvent* event) { - stream << std::fixed << std::setprecision(TRACE_precision()); - stream << (int) event->event_type; -} +/* internal do the instrumentation module */ +void simgrid::instr::PajeEvent::insertIntoBuffer() +{ + if (not TRACE_buffer()) { + print(); + delete this; + return; + } + buffer_debug(&buffer); + + XBT_DEBUG("%s: insert event_type=%u, timestamp=%f, buffersize=%zu)", __FUNCTION__, eventType_, timestamp_, + buffer.size()); + std::vector::reverse_iterator i; + for (i = buffer.rbegin(); i != buffer.rend(); ++i) { + simgrid::instr::PajeEvent* e1 = *i; + XBT_DEBUG("compare to %p is of type %u; timestamp:%f", e1, e1->eventType_, e1->timestamp_); + if (e1->timestamp_ <= timestamp_) + break; + } + if (i == buffer.rend()) + XBT_DEBUG("%s: inserted at beginning", __FUNCTION__); + else if (i == buffer.rbegin()) + XBT_DEBUG("%s: inserted at end", __FUNCTION__); + else + XBT_DEBUG("%s: inserted at pos= %zd from its end", __FUNCTION__, std::distance(buffer.rbegin(), i)); + buffer.insert(i.base(), this); -static void print_row() { - stream << std::endl; - fprintf(tracing_file, "%s", stream.str().c_str()); - XBT_DEBUG("Dump %s", stream.str().c_str()); - stream.str(""); - stream.clear(); + buffer_debug(&buffer); } -static void print_timestamp(PajeEvent* event) { - stream << " "; - /* prevent 0.0000 in the trace - this was the behavior before the transition to c++ */ - if (event->timestamp < 1e-12) - stream << 0; - else - stream << event->timestamp; -} - void TRACE_paje_start() { char *filename = TRACE_get_filename(); tracing_file = fopen(filename, "w"); @@ -89,220 +154,25 @@ void TRACE_paje_end() { XBT_DEBUG("Filename %s is closed", filename); } -void DefineContainerEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - stream << " " << type->id - << " " << type->father->id - << " " << type->name; - print_row(); -} - -void DefineVariableTypeEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - stream << " " << type->id - << " " << type->father->id - << " " << type->name; - if (type->color) - stream << " \"" << type->color << "\""; - print_row(); -} - -void DefineStateTypeEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - stream << " " << type->id - << " " << type->father->id - << " " << type->name; - print_row(); -} - -void DefineEventTypeEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - stream << " " << type->id - << " " << type->father->id - << " " << type->name; - print_row(); -} - -void DefineLinkTypeEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream (this); - stream << " " << type->id - << " " << type->father->id - << " " << source->id - << " " << dest->id - << " " << type->name; - print_row(); -} - -void DefineEntityValueEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - stream << " " << value->id - << " " << value->father->id - << " " << value->name; - if(value->color) - stream << " \"" << value->color << "\""; - print_row(); -} - -void CreateContainerEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << container->id - << " " << container->type->id - << " " << container->father->id - << " \"" << container->name << "\""; - - print_row(); -} - -void DestroyContainerEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << container->type->id - << " " << container->id; - - print_row(); -} - -void SetVariableEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id - << " " << value; - print_row(); -} - -void AddVariableEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id - << " " << value; - print_row(); -} - -void SubVariableEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id - << " " << value; - print_row(); -} - -void SetStateEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id; - stream << " " <id; -#if HAVE_SMPI - if (xbt_cfg_get_boolean("smpi/trace-call-location")) { - stream << " \"" << filename - << "\" " << linenumber; - } -#endif - print_row(); -} - -void PushStateEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id; - stream << " " <id; - - if (TRACE_display_sizes()) { - stream << " "; - if (extra != nullptr) { - stream << static_cast(extra)->send_size; - } - else { - stream << 0; - } - } -#if HAVE_SMPI - if (xbt_cfg_get_boolean("smpi/trace-call-location")) { - stream << " \"" << filename - << "\" " << linenumber; - } -#endif - print_row(); - - if (extra != nullptr) { - if (static_cast(extra)->sendcounts != nullptr) - xbt_free(static_cast(extra)->sendcounts); - if (static_cast(extra)->recvcounts != nullptr) - xbt_free(static_cast(extra)->recvcounts); - xbt_free(extra); - } -} - -void PopStateEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id; - print_row(); -} -void ResetStateEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id; - print_row(); -} +void TRACE_TI_start() +{ + char *filename = TRACE_get_filename(); + tracing_file = fopen(filename, "w"); + if (tracing_file == nullptr) + THROWF(system_error, 1, "Tracefile %s could not be opened for writing.", filename); -void StartLinkEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " <id - << " " <id - << " " <id - << " " << key; + XBT_DEBUG("Filename %s is open for writing", filename); - if (TRACE_display_sizes()) { - stream << " " << size; - } - print_row(); -} + /* output one line comment */ + dump_comment(TRACE_get_comment()); -void EndLinkEvent::print() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream(this); - print_timestamp(this); - stream << " " <id - << " " <id - << " " <id - << " " << key; - print_row(); + /* output comment file */ + dump_comment_file(TRACE_get_comment_file()); } -void NewEvent::print () { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event_type, TRACE_precision(), timestamp); - init_stream (this); - print_timestamp(this); - stream << " " << type->id - << " " << container->id - << " " << value->id; - print_row(); +void TRACE_TI_end() +{ + fclose(tracing_file); + XBT_DEBUG("Filename %s is closed", TRACE_get_filename()); }