X-Git-Url: http://info.iut-bm.univ-fcomte.fr/pub/gitweb/simgrid.git/blobdiff_plain/248c778108ab3c1520701f398a5848cd4c8c3870..9383e83f66e7cb0180d6acfc435d2622615c2c7f:/src/instr/instr_paje_trace.cpp diff --git a/src/instr/instr_paje_trace.cpp b/src/instr/instr_paje_trace.cpp index f55fec4d18..c8a069aea9 100644 --- a/src/instr/instr_paje_trace.cpp +++ b/src/instr/instr_paje_trace.cpp @@ -1,46 +1,126 @@ -/* Copyright (c) 2010-2015. 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 "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 -#include /** std::setprecision **/ +#include -XBT_LOG_NEW_DEFAULT_SUBCATEGORY(instr_paje_trace, instr_trace, "tracing event system"); +XBT_LOG_NEW_DEFAULT_SUBCATEGORY(instr_paje_trace, instr, "tracing event system"); -extern FILE * tracing_file; -extern s_instr_trace_writer_t active_writer; +static std::stringstream stream; +FILE *tracing_file = nullptr; -void TRACE_paje_init(void) +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) { - active_writer.print_DefineContainerType = print_pajeDefineContainerType; - active_writer.print_DefineVariableType = print_pajeDefineVariableType; - active_writer.print_DefineStateType = print_pajeDefineStateType; - active_writer.print_DefineEventType = print_pajeDefineEventType; - active_writer.print_DefineLinkType = print_pajeDefineLinkType; - active_writer.print_DefineEntityValue = print_pajeDefineEntityValue; - active_writer.print_CreateContainer = print_pajeCreateContainer; - active_writer.print_DestroyContainer = print_pajeDestroyContainer; - active_writer.print_SetVariable = print_pajeSetVariable; - active_writer.print_AddVariable = print_pajeAddVariable; - active_writer.print_SubVariable = print_pajeSubVariable; - active_writer.print_SetState = print_pajeSetState; - active_writer.print_PushState = print_pajePushState; - active_writer.print_PopState = print_pajePopState; - active_writer.print_ResetState = print_pajeResetState; - active_writer.print_StartLink = print_pajeStartLink; - active_writer.print_EndLink = print_pajeEndLink; - active_writer.print_NewEvent = print_pajeNewEvent; + 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 TRACE_paje_start(void) +void buffer_debug(std::vector* buf) { + return; + XBT_DEBUG(">>>>>> Dump the state of the buffer. %zu events", buf->size()); + for (auto const& event : *buf) { + event->print(); + XBT_DEBUG("%p %s", event, stream.str().c_str()); + stream.str(""); + stream.clear(); + } + XBT_DEBUG("<<<<<<"); +} + +/* 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); + + buffer_debug(&buffer); +} + +void TRACE_paje_start() { char *filename = TRACE_get_filename(); tracing_file = fopen(filename, "w"); - if (tracing_file == NULL){ + if (tracing_file == nullptr){ THROWF (system_error, 1, "Tracefile %s could not be opened for writing.", filename); } @@ -67,267 +147,31 @@ void TRACE_paje_start(void) TRACE_header(TRACE_basic(),TRACE_display_sizes()); } -void TRACE_paje_end(void) -{ +void TRACE_paje_end() { fclose(tracing_file); char *filename = TRACE_get_filename(); XBT_DEBUG("Filename %s is closed", filename); } -void print_pajeDefineContainerType(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s\n", (int)event->event_type, ((defineContainerType_t)event->data)->type->id, - ((defineContainerType_t)event->data)->type->father->id, ((defineContainerType_t)event->data)->type->name); -} - -void print_pajeDefineVariableType(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s \"%s\"\n", (int)event->event_type, - ((defineVariableType_t)event->data)->type->id, ((defineVariableType_t)event->data)->type->father->id, - ((defineVariableType_t)event->data)->type->name, ((defineVariableType_t)event->data)->type->color); -} - -void print_pajeDefineStateType(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s\n", (int)event->event_type, ((defineStateType_t)event->data)->type->id, - ((defineStateType_t)event->data)->type->father->id, ((defineStateType_t)event->data)->type->name); -} - -void print_pajeDefineEventType(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s\n", (int)event->event_type, ((defineEventType_t)event->data)->type->id, - ((defineEventType_t)event->data)->type->father->id, ((defineEventType_t)event->data)->type->name); -} - -void print_pajeDefineLinkType(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s %s %s\n", (int)event->event_type, ((defineLinkType_t)event->data)->type->id, - ((defineLinkType_t)event->data)->type->father->id, ((defineLinkType_t)event->data)->source->id, - ((defineLinkType_t)event->data)->dest->id, ((defineLinkType_t)event->data)->type->name); -} - -void print_pajeDefineEntityValue (paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d", __FUNCTION__, (int)event->event_type); - fprintf(tracing_file, "%d %s %s %s \"%s\"\n", (int)event->event_type, ((defineEntityValue_t)event->data)->value->id, - ((defineEntityValue_t)event->data)->value->father->id, ((defineEntityValue_t)event->data)->value->name, - ((defineEntityValue_t)event->data)->value->color); -} -void print_pajeCreateContainer(paje_event_t event) +void TRACE_TI_start() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s \"%s\"\n", (int)event->event_type, - ((createContainer_t)event->data)->container->id, ((createContainer_t)event->data)->container->type->id, - ((createContainer_t)event->data)->container->father->id, ((createContainer_t)event->data)->container->name); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %s \"%s\"\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((createContainer_t)event->data)->container->id, ((createContainer_t)event->data)->container->type->id, - ((createContainer_t)event->data)->container->father->id, ((createContainer_t)event->data)->container->name); - } -} - -void print_pajeDestroyContainer(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s\n", (int)event->event_type, - ((destroyContainer_t)event->data)->container->type->id, ((destroyContainer_t)event->data)->container->id); - }else{ - fprintf(tracing_file, "%d %.*f %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((destroyContainer_t)event->data)->container->type->id, ((destroyContainer_t)event->data)->container->id); - } -} - -void print_pajeSetVariable(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %f\n", (int)event->event_type, ((setVariable_t)event->data)->type->id, - ((setVariable_t)event->data)->container->id, ((setVariable_t)event->data)->value); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %f\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((setVariable_t)event->data)->type->id, ((setVariable_t)event->data)->container->id, - ((setVariable_t)event->data)->value); - } -} - -void print_pajeAddVariable(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %f\n", (int)event->event_type, ((addVariable_t)event->data)->type->id, - ((addVariable_t)event->data)->container->id, ((addVariable_t)event->data)->value); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %f\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((addVariable_t)event->data)->type->id, ((addVariable_t)event->data)->container->id, - ((addVariable_t)event->data)->value); - } -} - -void print_pajeSubVariable(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %f\n", (int)event->event_type, ((subVariable_t)event->data)->type->id, - ((subVariable_t)event->data)->container->id, ((subVariable_t)event->data)->value); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %f\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((subVariable_t)event->data)->type->id, ((subVariable_t)event->data)->container->id, - ((subVariable_t)event->data)->value); - } -} - -void print_pajeSetState(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s\n", (int)event->event_type, ((setState_t)event->data)->type->id, - ((setState_t)event->data)->container->id, ((setState_t)event->data)->value->id); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((setState_t)event->data)->type->id, ((setState_t)event->data)->container->id, - ((setState_t)event->data)->value->id); - } -} - -void print_pajePushState(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - - std::stringstream stream; - stream << std::fixed << std::setprecision(TRACE_precision()); - - stream << (int) event->event_type - << " "; - - /** prevent 0.0000 in the trace - this was the behavior before the transition to c++ **/ - if (event->timestamp == 0) - stream << 0; - else - stream << event->timestamp; - - stream << " " << ((pushState_t)event->data)->type->id - << " " << ((pushState_t)event->data)->container->id - << " " << ((pushState_t)event->data)->value->id; - - if (TRACE_display_sizes()) { - stream << " "; - if (((pushState_t)event->data)->extra != NULL) { - stream << ((instr_extra_data)((pushState_t)event->data)->extra)->send_size; - } - else { - stream << 0; - } - } - stream << std::endl; - - // TODO: This can be removed as soon as TRACE_paje_start() has been migrated - fprintf(tracing_file, "%s", stream.str().c_str()); - - if(((pushState_t)event->data)->extra!=NULL){ - if(((instr_extra_data)((pushState_t)event->data)->extra)->sendcounts!=NULL) - xbt_free(((instr_extra_data)((pushState_t)event->data)->extra)->sendcounts); - if(((instr_extra_data)((pushState_t)event->data)->extra)->recvcounts!=NULL) - xbt_free(((instr_extra_data)((pushState_t)event->data)->extra)->recvcounts); - xbt_free(((pushState_t)event->data)->extra); - } -} - -void print_pajePopState(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s\n", (int)event->event_type, ((popState_t)event->data)->type->id, - ((popState_t)event->data)->container->id); - }else{ - fprintf(tracing_file, "%d %.*f %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((popState_t)event->data)->type->id, ((popState_t)event->data)->container->id); - } -} + 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 print_pajeResetState(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s\n", (int)event->event_type, ((resetState_t)event->data)->type->id, - ((resetState_t)event->data)->container->id); - }else{ - fprintf(tracing_file, "%d %.*f %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((resetState_t)event->data)->type->id, ((resetState_t)event->data)->container->id); - } -} + XBT_DEBUG("Filename %s is open for writing", filename); -void print_pajeStartLink(paje_event_t event) -{ - if (!TRACE_display_sizes()){ - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s %s %s\n", (int)event->event_type, ((startLink_t)event->data)->type->id, - ((startLink_t)event->data)->container->id, ((startLink_t)event->data)->value, - ((startLink_t)event->data)->sourceContainer->id, ((startLink_t)event->data)->key); - }else { - fprintf(tracing_file, "%d %.*f %s %s %s %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((startLink_t)event->data)->type->id, ((startLink_t)event->data)->container->id, - ((startLink_t)event->data)->value, ((startLink_t)event->data)->sourceContainer->id, - ((startLink_t)event->data)->key); - } - }else{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s %s %s %d\n", (int)event->event_type, ((startLink_t)event->data)->type->id, - ((startLink_t)event->data)->container->id, ((startLink_t)event->data)->value, - ((startLink_t)event->data)->sourceContainer->id, ((startLink_t)event->data)->key, - ((startLink_t)event->data)->size); - }else { - fprintf(tracing_file, "%d %.*f %s %s %s %s %s %d\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((startLink_t)event->data)->type->id, ((startLink_t)event->data)->container->id, - ((startLink_t)event->data)->value, ((startLink_t)event->data)->sourceContainer->id, - ((startLink_t)event->data)->key, ((startLink_t)event->data)->size); - } - } -} + /* output one line comment */ + dump_comment(TRACE_get_comment()); -void print_pajeEndLink(paje_event_t event) -{ - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s %s %s\n", (int)event->event_type, ((endLink_t)event->data)->type->id, - ((endLink_t)event->data)->container->id, ((endLink_t)event->data)->value, - ((endLink_t)event->data)->destContainer->id, ((endLink_t)event->data)->key); - }else { - fprintf(tracing_file, "%d %.*f %s %s %s %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((endLink_t)event->data)->type->id, ((endLink_t)event->data)->container->id, ((endLink_t)event->data)->value, - ((endLink_t)event->data)->destContainer->id, ((endLink_t)event->data)->key); - } + /* output comment file */ + dump_comment_file(TRACE_get_comment_file()); } -void print_pajeNewEvent (paje_event_t event) +void TRACE_TI_end() { - XBT_DEBUG("%s: event_type=%d, timestamp=%.*f", __FUNCTION__, (int)event->event_type, TRACE_precision(), - event->timestamp); - if (event->timestamp == 0){ - fprintf(tracing_file, "%d 0 %s %s %s\n", (int)event->event_type, ((newEvent_t)event->data)->type->id, - ((newEvent_t)event->data)->container->id, ((newEvent_t)event->data)->value->id); - }else{ - fprintf(tracing_file, "%d %.*f %s %s %s\n", (int)event->event_type, TRACE_precision(), event->timestamp, - ((newEvent_t)event->data)->type->id, ((newEvent_t)event->data)->container->id, - ((newEvent_t)event->data)->value->id); - } + fclose(tracing_file); + XBT_DEBUG("Filename %s is closed", TRACE_get_filename()); }