xref: /petsc/src/sys/logging/handler/impls/default/logdefault.c (revision dff009be1503132eb32dbaedc8512f49b68e5e4c)
178f1b9b4SToby Isaac #include <petscviewer.h>
278f1b9b4SToby Isaac #include <petscdevice.h>
378f1b9b4SToby Isaac #include <petsc/private/logimpl.h> /*I "petscsys.h" I*/
478f1b9b4SToby Isaac #include <petsc/private/loghandlerimpl.h>
578f1b9b4SToby Isaac #include <petsc/private/deviceimpl.h>
678f1b9b4SToby Isaac #include <petscconfiginfo.h>
778f1b9b4SToby Isaac #include <petscmachineinfo.h>
878f1b9b4SToby Isaac #include "logdefault.h"
978f1b9b4SToby Isaac 
1078f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoInit(PetscEventPerfInfo *eventInfo)
1178f1b9b4SToby Isaac {
1278f1b9b4SToby Isaac   PetscFunctionBegin;
1378f1b9b4SToby Isaac   PetscCall(PetscMemzero(eventInfo, sizeof(*eventInfo)));
1478f1b9b4SToby Isaac   eventInfo->visible   = PETSC_TRUE;
1578f1b9b4SToby Isaac   eventInfo->id        = -1;
1678f1b9b4SToby Isaac   eventInfo->dof[0]    = -1.0;
1778f1b9b4SToby Isaac   eventInfo->dof[1]    = -1.0;
1878f1b9b4SToby Isaac   eventInfo->dof[2]    = -1.0;
1978f1b9b4SToby Isaac   eventInfo->dof[3]    = -1.0;
2078f1b9b4SToby Isaac   eventInfo->dof[4]    = -1.0;
2178f1b9b4SToby Isaac   eventInfo->dof[5]    = -1.0;
2278f1b9b4SToby Isaac   eventInfo->dof[6]    = -1.0;
2378f1b9b4SToby Isaac   eventInfo->dof[7]    = -1.0;
2478f1b9b4SToby Isaac   eventInfo->errors[0] = -1.0;
2578f1b9b4SToby Isaac   eventInfo->errors[1] = -1.0;
2678f1b9b4SToby Isaac   eventInfo->errors[2] = -1.0;
2778f1b9b4SToby Isaac   eventInfo->errors[3] = -1.0;
2878f1b9b4SToby Isaac   eventInfo->errors[4] = -1.0;
2978f1b9b4SToby Isaac   eventInfo->errors[5] = -1.0;
3078f1b9b4SToby Isaac   eventInfo->errors[6] = -1.0;
3178f1b9b4SToby Isaac   eventInfo->errors[7] = -1.0;
3278f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
3378f1b9b4SToby Isaac }
3478f1b9b4SToby Isaac 
3578f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoTic_Internal(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event, PetscBool resume)
3678f1b9b4SToby Isaac {
3778f1b9b4SToby Isaac   PetscFunctionBegin;
3878f1b9b4SToby Isaac   if (resume) {
3978f1b9b4SToby Isaac     eventInfo->timeTmp -= time;
4078f1b9b4SToby Isaac     eventInfo->flopsTmp -= petsc_TotalFlops_th;
4178f1b9b4SToby Isaac   } else {
4278f1b9b4SToby Isaac     eventInfo->timeTmp  = -time;
4378f1b9b4SToby Isaac     eventInfo->flopsTmp = -petsc_TotalFlops_th;
4478f1b9b4SToby Isaac   }
4578f1b9b4SToby Isaac   eventInfo->numMessages -= petsc_irecv_ct_th + petsc_isend_ct_th + petsc_recv_ct_th + petsc_send_ct_th;
4678f1b9b4SToby Isaac   eventInfo->messageLength -= petsc_irecv_len_th + petsc_isend_len_th + petsc_recv_len_th + petsc_send_len_th;
4778f1b9b4SToby Isaac   eventInfo->numReductions -= petsc_allreduce_ct_th + petsc_gather_ct_th + petsc_scatter_ct_th;
4878f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
4978f1b9b4SToby Isaac   eventInfo->CpuToGpuCount -= petsc_ctog_ct_th;
5078f1b9b4SToby Isaac   eventInfo->GpuToCpuCount -= petsc_gtoc_ct_th;
5178f1b9b4SToby Isaac   eventInfo->CpuToGpuSize -= petsc_ctog_sz_th;
5278f1b9b4SToby Isaac   eventInfo->GpuToCpuSize -= petsc_gtoc_sz_th;
5378f1b9b4SToby Isaac   eventInfo->GpuFlops -= petsc_gflops_th;
5478f1b9b4SToby Isaac   eventInfo->GpuTime -= petsc_gtime;
5578f1b9b4SToby Isaac #endif
5678f1b9b4SToby Isaac   if (logMemory) {
5778f1b9b4SToby Isaac     PetscLogDouble usage;
5878f1b9b4SToby Isaac     PetscCall(PetscMemoryGetCurrentUsage(&usage));
5978f1b9b4SToby Isaac     eventInfo->memIncrease -= usage;
6078f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&usage));
6178f1b9b4SToby Isaac     eventInfo->mallocSpace -= usage;
6278f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&usage));
6378f1b9b4SToby Isaac     eventInfo->mallocIncrease -= usage;
6478f1b9b4SToby Isaac     PetscCall(PetscMallocPushMaximumUsage(event));
6578f1b9b4SToby Isaac   }
6678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
6778f1b9b4SToby Isaac }
6878f1b9b4SToby Isaac 
6978f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoTic(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event)
7078f1b9b4SToby Isaac {
7178f1b9b4SToby Isaac   PetscFunctionBegin;
7278f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoTic_Internal(eventInfo, time, logMemory, event, PETSC_FALSE));
7378f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
7478f1b9b4SToby Isaac }
7578f1b9b4SToby Isaac 
7678f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoResume(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event)
7778f1b9b4SToby Isaac {
7878f1b9b4SToby Isaac   PetscFunctionBegin;
7978f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoTic_Internal(eventInfo, time, logMemory, event, PETSC_TRUE));
8078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
8178f1b9b4SToby Isaac }
8278f1b9b4SToby Isaac 
8378f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoToc_Internal(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event, PetscBool pause)
8478f1b9b4SToby Isaac {
8578f1b9b4SToby Isaac   PetscFunctionBegin;
8678f1b9b4SToby Isaac   eventInfo->timeTmp += time;
8778f1b9b4SToby Isaac   eventInfo->flopsTmp += petsc_TotalFlops_th;
8878f1b9b4SToby Isaac   if (!pause) {
8978f1b9b4SToby Isaac     eventInfo->time += eventInfo->timeTmp;
9078f1b9b4SToby Isaac     eventInfo->time2 += eventInfo->timeTmp * eventInfo->timeTmp;
9178f1b9b4SToby Isaac     eventInfo->flops += eventInfo->flopsTmp;
9278f1b9b4SToby Isaac     eventInfo->flops2 += eventInfo->flopsTmp * eventInfo->flopsTmp;
9378f1b9b4SToby Isaac   }
9478f1b9b4SToby Isaac   eventInfo->numMessages += petsc_irecv_ct_th + petsc_isend_ct_th + petsc_recv_ct_th + petsc_send_ct_th;
9578f1b9b4SToby Isaac   eventInfo->messageLength += petsc_irecv_len_th + petsc_isend_len_th + petsc_recv_len + petsc_send_len_th;
9678f1b9b4SToby Isaac   eventInfo->numReductions += petsc_allreduce_ct_th + petsc_gather_ct_th + petsc_scatter_ct_th;
9778f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
9878f1b9b4SToby Isaac   eventInfo->CpuToGpuCount += petsc_ctog_ct_th;
9978f1b9b4SToby Isaac   eventInfo->GpuToCpuCount += petsc_gtoc_ct_th;
10078f1b9b4SToby Isaac   eventInfo->CpuToGpuSize += petsc_ctog_sz_th;
10178f1b9b4SToby Isaac   eventInfo->GpuToCpuSize += petsc_gtoc_sz_th;
10278f1b9b4SToby Isaac   eventInfo->GpuFlops += petsc_gflops_th;
10378f1b9b4SToby Isaac   eventInfo->GpuTime += petsc_gtime;
10478f1b9b4SToby Isaac #endif
10578f1b9b4SToby Isaac   if (logMemory) {
10678f1b9b4SToby Isaac     PetscLogDouble usage, musage;
10778f1b9b4SToby Isaac     PetscCall(PetscMemoryGetCurrentUsage(&usage)); /* the comments below match the column labels printed in PetscLogView_Default() */
10878f1b9b4SToby Isaac     eventInfo->memIncrease += usage;               /* RMI */
10978f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&usage));
11078f1b9b4SToby Isaac     eventInfo->mallocSpace += usage; /* Malloc */
11178f1b9b4SToby Isaac     PetscCall(PetscMallocPopMaximumUsage((int)event, &musage));
11278f1b9b4SToby Isaac     eventInfo->mallocIncreaseEvent = PetscMax(musage - usage, eventInfo->mallocIncreaseEvent); /* EMalloc */
11378f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&usage));
11478f1b9b4SToby Isaac     eventInfo->mallocIncrease += usage; /* MMalloc */
11578f1b9b4SToby Isaac   }
11678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
11778f1b9b4SToby Isaac }
11878f1b9b4SToby Isaac 
11978f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoToc(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event)
12078f1b9b4SToby Isaac {
12178f1b9b4SToby Isaac   PetscFunctionBegin;
12278f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoToc_Internal(eventInfo, time, logMemory, event, PETSC_FALSE));
12378f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
12478f1b9b4SToby Isaac }
12578f1b9b4SToby Isaac 
12678f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoPause(PetscEventPerfInfo *eventInfo, PetscLogDouble time, PetscBool logMemory, int event)
12778f1b9b4SToby Isaac {
12878f1b9b4SToby Isaac   PetscFunctionBegin;
12978f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoToc_Internal(eventInfo, time, logMemory, event, PETSC_FALSE));
13078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
13178f1b9b4SToby Isaac }
13278f1b9b4SToby Isaac 
13378f1b9b4SToby Isaac static PetscErrorCode PetscEventPerfInfoAdd_Internal(const PetscEventPerfInfo *eventInfo, PetscEventPerfInfo *outInfo)
13478f1b9b4SToby Isaac {
13578f1b9b4SToby Isaac   PetscFunctionBegin;
13678f1b9b4SToby Isaac   outInfo->count += eventInfo->count;
13778f1b9b4SToby Isaac   outInfo->time += eventInfo->time;
13878f1b9b4SToby Isaac   outInfo->time2 += eventInfo->time2;
13978f1b9b4SToby Isaac   outInfo->flops += eventInfo->flops;
14078f1b9b4SToby Isaac   outInfo->flops2 += eventInfo->flops2;
14178f1b9b4SToby Isaac   outInfo->numMessages += eventInfo->numMessages;
14278f1b9b4SToby Isaac   outInfo->messageLength += eventInfo->messageLength;
14378f1b9b4SToby Isaac   outInfo->numReductions += eventInfo->numReductions;
14478f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
14578f1b9b4SToby Isaac   outInfo->CpuToGpuCount += eventInfo->CpuToGpuCount;
14678f1b9b4SToby Isaac   outInfo->GpuToCpuCount += eventInfo->GpuToCpuCount;
14778f1b9b4SToby Isaac   outInfo->CpuToGpuSize += eventInfo->CpuToGpuSize;
14878f1b9b4SToby Isaac   outInfo->GpuToCpuSize += eventInfo->GpuToCpuSize;
14978f1b9b4SToby Isaac   outInfo->GpuFlops += eventInfo->GpuFlops;
15078f1b9b4SToby Isaac   outInfo->GpuTime += eventInfo->GpuTime;
15178f1b9b4SToby Isaac #endif
15278f1b9b4SToby Isaac   outInfo->memIncrease += eventInfo->memIncrease;
15378f1b9b4SToby Isaac   outInfo->mallocSpace += eventInfo->mallocSpace;
15478f1b9b4SToby Isaac   outInfo->mallocIncreaseEvent += eventInfo->mallocIncreaseEvent;
15578f1b9b4SToby Isaac   outInfo->mallocIncrease += eventInfo->mallocIncrease;
15678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
15778f1b9b4SToby Isaac }
15878f1b9b4SToby Isaac 
15978f1b9b4SToby Isaac PETSC_LOG_RESIZABLE_ARRAY(EventPerfArray, PetscEventPerfInfo, PetscLogEvent, PetscEventPerfInfoInit, NULL, NULL)
16078f1b9b4SToby Isaac 
16178f1b9b4SToby Isaac /* --- PetscClassPerf --- */
16278f1b9b4SToby Isaac 
16378f1b9b4SToby Isaac typedef struct {
16478f1b9b4SToby Isaac   int            creations;    /* The number of objects of this class created */
16578f1b9b4SToby Isaac   int            destructions; /* The number of objects of this class destroyed */
16678f1b9b4SToby Isaac   PetscLogDouble mem;          /* The total memory allocated by objects of this class; this is completely wrong and should possibly be removed */
16778f1b9b4SToby Isaac   PetscLogDouble descMem;      /* The total memory allocated by descendents of these objects; this is completely wrong and should possibly be removed */
16878f1b9b4SToby Isaac } PetscClassPerf;
16978f1b9b4SToby Isaac 
17078f1b9b4SToby Isaac static PetscErrorCode PetscClassPerfInit(PetscClassPerf *classInfo)
17178f1b9b4SToby Isaac {
17278f1b9b4SToby Isaac   PetscFunctionBegin;
17378f1b9b4SToby Isaac   PetscCall(PetscMemzero(classInfo, sizeof(*classInfo)));
17478f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
17578f1b9b4SToby Isaac }
17678f1b9b4SToby Isaac 
17778f1b9b4SToby Isaac PETSC_LOG_RESIZABLE_ARRAY(ClassPerfArray, PetscClassPerf, PetscLogClass, PetscClassPerfInit, NULL, NULL)
17878f1b9b4SToby Isaac 
17978f1b9b4SToby Isaac /* --- PetscStagePerf --- */
18078f1b9b4SToby Isaac 
18178f1b9b4SToby Isaac typedef struct _PetscStagePerf {
18278f1b9b4SToby Isaac   PetscBool              used;     /* The stage was pushed on this processor */
18378f1b9b4SToby Isaac   PetscEventPerfInfo     perfInfo; /* The stage performance information */
18478f1b9b4SToby Isaac   PetscLogEventPerfArray eventLog; /* The event information for this stage */
18578f1b9b4SToby Isaac   PetscLogClassPerfArray classLog; /* The class information for this stage */
18678f1b9b4SToby Isaac } PetscStagePerf;
18778f1b9b4SToby Isaac 
18878f1b9b4SToby Isaac static PetscErrorCode PetscStageInfoInit(PetscStagePerf *stageInfo)
18978f1b9b4SToby Isaac {
19078f1b9b4SToby Isaac   PetscFunctionBegin;
19178f1b9b4SToby Isaac   PetscCall(PetscMemzero(stageInfo, sizeof(*stageInfo)));
19278f1b9b4SToby Isaac   PetscCall(PetscLogEventPerfArrayCreate(128, &(stageInfo->eventLog)));
19378f1b9b4SToby Isaac   PetscCall(PetscLogClassPerfArrayCreate(128, &(stageInfo->classLog)));
19478f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoInit(&stageInfo->perfInfo));
19578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
19678f1b9b4SToby Isaac }
19778f1b9b4SToby Isaac 
19878f1b9b4SToby Isaac static PetscErrorCode PetscStageInfoReset(PetscStagePerf *stageInfo)
19978f1b9b4SToby Isaac {
20078f1b9b4SToby Isaac   PetscFunctionBegin;
20178f1b9b4SToby Isaac   PetscCall(PetscLogEventPerfArrayDestroy(&(stageInfo->eventLog)));
20278f1b9b4SToby Isaac   PetscCall(PetscLogClassPerfArrayDestroy(&(stageInfo->classLog)));
20378f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
20478f1b9b4SToby Isaac }
20578f1b9b4SToby Isaac 
20678f1b9b4SToby Isaac PETSC_LOG_RESIZABLE_ARRAY(StageInfoArray, PetscStagePerf, PetscLogStage, PetscStageInfoInit, PetscStageInfoReset, NULL)
20778f1b9b4SToby Isaac 
20878f1b9b4SToby Isaac /* --- Action --- */
20978f1b9b4SToby Isaac 
21078f1b9b4SToby Isaac /* The structure for action logging */
21178f1b9b4SToby Isaac typedef enum {
21278f1b9b4SToby Isaac   PETSC_LOG_ACTION_CREATE,
21378f1b9b4SToby Isaac   PETSC_LOG_ACTION_DESTROY,
21478f1b9b4SToby Isaac   PETSC_LOG_ACTION_BEGIN,
21578f1b9b4SToby Isaac   PETSC_LOG_ACTION_END,
21678f1b9b4SToby Isaac } PetscLogActionType;
21778f1b9b4SToby Isaac 
218b665b14eSToby Isaac typedef struct _Action {
219b665b14eSToby Isaac   PetscLogActionType action;        /* The type of execution */
220b665b14eSToby Isaac   PetscLogEvent      event;         /* The event number */
221b665b14eSToby Isaac   PetscClassId       classid;       /* The event class id */
222b665b14eSToby Isaac   PetscLogDouble     time;          /* The time of occurrence */
223b665b14eSToby Isaac   PetscLogDouble     flops;         /* The cumulative flops */
224b665b14eSToby Isaac   PetscLogDouble     mem;           /* The current memory usage */
225b665b14eSToby Isaac   PetscLogDouble     maxmem;        /* The maximum memory usage */
226b665b14eSToby Isaac   int                id1, id2, id3; /* The ids of associated objects */
227b665b14eSToby Isaac } Action;
228b665b14eSToby Isaac 
22978f1b9b4SToby Isaac PETSC_LOG_RESIZABLE_ARRAY(ActionArray, Action, PetscLogEvent, NULL, NULL, NULL)
23078f1b9b4SToby Isaac 
23178f1b9b4SToby Isaac /* --- Object --- */
23278f1b9b4SToby Isaac 
233b665b14eSToby Isaac /* The structure for object logging */
234b665b14eSToby Isaac typedef struct _Object {
235b665b14eSToby Isaac   PetscObject    obj;      /* The associated PetscObject */
236b665b14eSToby Isaac   int            parent;   /* The parent id */
237b665b14eSToby Isaac   PetscLogDouble mem;      /* The memory associated with the object */
238b665b14eSToby Isaac   char           name[64]; /* The object name */
239b665b14eSToby Isaac   char           info[64]; /* The information string */
240b665b14eSToby Isaac } Object;
241b665b14eSToby Isaac 
24278f1b9b4SToby Isaac PETSC_LOG_RESIZABLE_ARRAY(ObjectArray, Object, PetscObject, NULL, NULL, NULL)
24378f1b9b4SToby Isaac 
24478f1b9b4SToby Isaac /* Map from (threadid,stage,event) to perfInfo data struct */
24578f1b9b4SToby Isaac #include <petsc/private/hashmapijk.h>
24678f1b9b4SToby Isaac 
24778f1b9b4SToby Isaac PETSC_HASH_MAP(HMapEvent, PetscHashIJKKey, PetscEventPerfInfo *, PetscHashIJKKeyHash, PetscHashIJKKeyEqual, NULL)
24878f1b9b4SToby Isaac 
24978f1b9b4SToby Isaac typedef struct _n_PetscLogHandler_Default *PetscLogHandler_Default;
25078f1b9b4SToby Isaac struct _n_PetscLogHandler_Default {
25178f1b9b4SToby Isaac   PetscLogStageInfoArray stages;
25278f1b9b4SToby Isaac   PetscSpinlock          lock;
25378f1b9b4SToby Isaac   PetscLogActionArray    petsc_actions;
25478f1b9b4SToby Isaac   PetscLogObjectArray    petsc_objects;
25578f1b9b4SToby Isaac   PetscBool              petsc_logActions;
25678f1b9b4SToby Isaac   PetscBool              petsc_logObjects;
25778f1b9b4SToby Isaac   int                    petsc_numObjectsCreated;
25878f1b9b4SToby Isaac   int                    petsc_numObjectsDestroyed;
25978f1b9b4SToby Isaac   PetscHMapEvent         eventInfoMap_th;
26078f1b9b4SToby Isaac   int                    pause_depth;
261461318ebSToby Isaac   PetscBool              use_threadsafe;
26278f1b9b4SToby Isaac };
26378f1b9b4SToby Isaac 
26478f1b9b4SToby Isaac /* --- PetscLogHandler_Default --- */
26578f1b9b4SToby Isaac 
26678f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerContextCreate_Default(PetscLogHandler_Default *def_p)
26778f1b9b4SToby Isaac {
26878f1b9b4SToby Isaac   PetscLogHandler_Default def;
26978f1b9b4SToby Isaac 
27078f1b9b4SToby Isaac   PetscFunctionBegin;
27178f1b9b4SToby Isaac   PetscCall(PetscNew(def_p));
27278f1b9b4SToby Isaac   def = *def_p;
27378f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayCreate(8, &(def->stages)));
27478f1b9b4SToby Isaac   PetscCall(PetscLogActionArrayCreate(64, &(def->petsc_actions)));
27578f1b9b4SToby Isaac   PetscCall(PetscLogObjectArrayCreate(64, &(def->petsc_objects)));
27678f1b9b4SToby Isaac 
27778f1b9b4SToby Isaac   PetscCall(PetscOptionsGetBool(NULL, NULL, "-log_include_actions", &def->petsc_logActions, NULL));
27878f1b9b4SToby Isaac   PetscCall(PetscOptionsGetBool(NULL, NULL, "-log_include_objects", &def->petsc_logObjects, NULL));
279461318ebSToby Isaac   PetscCall(PetscOptionsGetBool(NULL, NULL, "-log_handler_default_use_threadsafe_events", &def->use_threadsafe, NULL));
280461318ebSToby Isaac   if (PetscDefined(HAVE_THREADSAFETY) || def->use_threadsafe) { PetscCall(PetscHMapEventCreate(&def->eventInfoMap_th)); }
28178f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
28278f1b9b4SToby Isaac }
28378f1b9b4SToby Isaac 
28478f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerDestroy_Default(PetscLogHandler h)
28578f1b9b4SToby Isaac {
28678f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
28778f1b9b4SToby Isaac 
28878f1b9b4SToby Isaac   PetscFunctionBegin;
28978f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayDestroy(&def->stages));
29078f1b9b4SToby Isaac   PetscCall(PetscLogActionArrayDestroy(&def->petsc_actions));
29178f1b9b4SToby Isaac   PetscCall(PetscLogObjectArrayDestroy(&def->petsc_objects));
29278f1b9b4SToby Isaac   if (def->eventInfoMap_th) {
29378f1b9b4SToby Isaac     PetscEventPerfInfo **array;
29478f1b9b4SToby Isaac     PetscInt             n, off = 0;
29578f1b9b4SToby Isaac 
29678f1b9b4SToby Isaac     PetscCall(PetscHMapEventGetSize(def->eventInfoMap_th, &n));
29778f1b9b4SToby Isaac     PetscCall(PetscMalloc1(n, &array));
29878f1b9b4SToby Isaac     PetscCall(PetscHMapEventGetVals(def->eventInfoMap_th, &off, array));
29978f1b9b4SToby Isaac     for (PetscInt i = 0; i < n; i++) PetscCall(PetscFree(array[i]));
30078f1b9b4SToby Isaac     PetscCall(PetscFree(array));
30178f1b9b4SToby Isaac     PetscCall(PetscHMapEventDestroy(&def->eventInfoMap_th));
30278f1b9b4SToby Isaac   }
303*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerGetEventPerfInfo_C", NULL));
304*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerSetLogActions_C", NULL));
305*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerSetLogObjects_C", NULL));
306*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerLogObjectState_C", NULL));
307*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerGetNumObjects_C", NULL));
308*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerEventDeactivatePush_C", NULL));
309*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerEventDeactivatePop_C", NULL));
310*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerEventsPause_C", NULL));
311*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerEventsResume_C", NULL));
312*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerDump_C", NULL));
313*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerStageSetVisible_C", NULL));
314*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)h, "PetscLogHandlerStageGetVisible_C", NULL));
31578f1b9b4SToby Isaac   PetscCall(PetscFree(def));
31678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
31778f1b9b4SToby Isaac }
31878f1b9b4SToby Isaac 
31978f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerDefaultGetStageInfo(PetscLogHandler handler, PetscLogStage stage, PetscStagePerf **stage_info_p)
32078f1b9b4SToby Isaac {
32178f1b9b4SToby Isaac   PetscStagePerf         *stage_info = NULL;
32278f1b9b4SToby Isaac   PetscLogHandler_Default def        = (PetscLogHandler_Default)handler->data;
32378f1b9b4SToby Isaac 
32478f1b9b4SToby Isaac   PetscFunctionBegin;
32578f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayResize(def->stages, stage + 1));
32678f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayGetRef(def->stages, stage, &stage_info));
32778f1b9b4SToby Isaac   *stage_info_p = stage_info;
32878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
32978f1b9b4SToby Isaac }
33078f1b9b4SToby Isaac 
331*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerGetEventPerfInfo_Default(PetscLogHandler handler, PetscLogStage stage, PetscLogEvent event, PetscEventPerfInfo **event_info_p)
33278f1b9b4SToby Isaac {
33378f1b9b4SToby Isaac   PetscEventPerfInfo    *event_info = NULL;
33478f1b9b4SToby Isaac   PetscStagePerf        *stage_info = NULL;
33578f1b9b4SToby Isaac   PetscLogEventPerfArray event_log;
33678f1b9b4SToby Isaac 
33778f1b9b4SToby Isaac   PetscFunctionBegin;
33878f1b9b4SToby Isaac   if (stage < 0) PetscCall(PetscLogStateGetCurrentStage(handler->state, &stage));
33978f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage, &stage_info));
34078f1b9b4SToby Isaac   event_log = stage_info->eventLog;
34178f1b9b4SToby Isaac   PetscCall(PetscLogEventPerfArrayResize(event_log, event + 1));
34278f1b9b4SToby Isaac   PetscCall(PetscLogEventPerfArrayGetRef(event_log, event, &event_info));
34378f1b9b4SToby Isaac   event_info->id = event;
34478f1b9b4SToby Isaac   *event_info_p  = event_info;
34578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
34678f1b9b4SToby Isaac }
34778f1b9b4SToby Isaac 
34878f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerDefaultGetClassPerf(PetscLogHandler handler, PetscLogStage stage, PetscLogClass clss, PetscClassPerf **class_info)
34978f1b9b4SToby Isaac {
35078f1b9b4SToby Isaac   PetscLogClassPerfArray class_log;
35178f1b9b4SToby Isaac   PetscStagePerf        *stage_info;
35278f1b9b4SToby Isaac 
35378f1b9b4SToby Isaac   PetscFunctionBegin;
35478f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage, &stage_info));
35578f1b9b4SToby Isaac   class_log = stage_info->classLog;
35678f1b9b4SToby Isaac   PetscCall(PetscLogClassPerfArrayResize(class_log, clss + 1));
35778f1b9b4SToby Isaac   PetscCall(PetscLogClassPerfArrayGetRef(class_log, clss, class_info));
35878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
35978f1b9b4SToby Isaac }
36078f1b9b4SToby Isaac 
36178f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerObjectCreate_Default(PetscLogHandler h, PetscObject obj)
36278f1b9b4SToby Isaac {
36378f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
36478f1b9b4SToby Isaac   PetscLogState           state;
36578f1b9b4SToby Isaac   PetscLogStage           stage;
36678f1b9b4SToby Isaac   PetscClassPerf         *classInfo;
36778f1b9b4SToby Isaac   int                     oclass = 0;
36878f1b9b4SToby Isaac 
36978f1b9b4SToby Isaac   PetscFunctionBegin;
37078f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
37178f1b9b4SToby Isaac   PetscCall(PetscSpinlockLock(&def->lock));
37278f1b9b4SToby Isaac   /* Record stage info */
37378f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &stage));
37478f1b9b4SToby Isaac   PetscCall(PetscLogStateGetClassFromClassId(state, obj->classid, &oclass));
37578f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetClassPerf(h, stage, oclass, &classInfo));
37678f1b9b4SToby Isaac   classInfo->creations++;
37778f1b9b4SToby Isaac   /* Record the creation action */
37878f1b9b4SToby Isaac   if (def->petsc_logActions) {
37978f1b9b4SToby Isaac     Action new_action;
38078f1b9b4SToby Isaac 
38178f1b9b4SToby Isaac     PetscCall(PetscTime(&new_action.time));
38278f1b9b4SToby Isaac     new_action.time -= petsc_BaseTime;
38378f1b9b4SToby Isaac     new_action.action  = PETSC_LOG_ACTION_CREATE;
38478f1b9b4SToby Isaac     new_action.event   = -1;
38578f1b9b4SToby Isaac     new_action.classid = obj->classid;
38678f1b9b4SToby Isaac     new_action.id1     = obj->id;
38778f1b9b4SToby Isaac     new_action.id2     = -1;
38878f1b9b4SToby Isaac     new_action.id3     = -1;
38978f1b9b4SToby Isaac     new_action.flops   = petsc_TotalFlops;
39078f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&new_action.mem));
39178f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&new_action.maxmem));
39278f1b9b4SToby Isaac     PetscCall(PetscLogActionArrayPush(def->petsc_actions, new_action));
39378f1b9b4SToby Isaac   }
39478f1b9b4SToby Isaac   /* We don't just use obj->id to count all objects that are created
39578f1b9b4SToby Isaac      because PetscLogHandlers are objects and PetscLogObjectDestroy() will not
39678f1b9b4SToby Isaac      be called for them: the number of objects created and destroyed as counted
39778f1b9b4SToby Isaac      here and below would have an imbalance */
39878f1b9b4SToby Isaac   def->petsc_numObjectsCreated++;
39978f1b9b4SToby Isaac   /* Record the object */
40078f1b9b4SToby Isaac   if (def->petsc_logObjects) {
40178f1b9b4SToby Isaac     Object new_object;
40278f1b9b4SToby Isaac 
40378f1b9b4SToby Isaac     new_object.parent = -1;
40478f1b9b4SToby Isaac     new_object.obj    = obj;
40578f1b9b4SToby Isaac     new_object.mem    = 0;
40678f1b9b4SToby Isaac 
40778f1b9b4SToby Isaac     PetscCall(PetscMemzero(new_object.name, sizeof(new_object.name)));
40878f1b9b4SToby Isaac     PetscCall(PetscMemzero(new_object.info, sizeof(new_object.info)));
40978f1b9b4SToby Isaac     PetscAssert(obj->id >= 1, PETSC_COMM_SELF, PETSC_ERR_PLIB, "Object ids from PetscObjectNewId_Internal() start at 1");
41078f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayResize(def->petsc_objects, obj->id));
41178f1b9b4SToby Isaac     PetscCall(PetscLogObjectArraySet(def->petsc_objects, obj->id - 1, new_object));
41278f1b9b4SToby Isaac   }
41378f1b9b4SToby Isaac   PetscCall(PetscSpinlockUnlock(&def->lock));
41478f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
41578f1b9b4SToby Isaac }
41678f1b9b4SToby Isaac 
41778f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerObjectDestroy_Default(PetscLogHandler h, PetscObject obj)
41878f1b9b4SToby Isaac {
41978f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
42078f1b9b4SToby Isaac   PetscLogState           state;
42178f1b9b4SToby Isaac   PetscLogStage           stage;
42278f1b9b4SToby Isaac   PetscClassPerf         *classInfo;
42378f1b9b4SToby Isaac   int                     oclass = 0;
42478f1b9b4SToby Isaac 
42578f1b9b4SToby Isaac   PetscFunctionBegin;
42678f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
42778f1b9b4SToby Isaac   /* Record stage info */
42878f1b9b4SToby Isaac   PetscCall(PetscSpinlockLock(&def->lock));
42978f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &stage));
43078f1b9b4SToby Isaac   if (stage >= 0) {
43178f1b9b4SToby Isaac     /* stage < 0 can happen if the log summary is output before some things are destroyed */
43278f1b9b4SToby Isaac     PetscCall(PetscLogStateGetClassFromClassId(state, obj->classid, &oclass));
43378f1b9b4SToby Isaac     PetscCall(PetscLogHandlerDefaultGetClassPerf(h, stage, oclass, &classInfo));
43478f1b9b4SToby Isaac     classInfo->destructions++;
43578f1b9b4SToby Isaac   }
43678f1b9b4SToby Isaac   /* Cannot Credit all ancestors with your memory because they may have already been destroyed*/
43778f1b9b4SToby Isaac   def->petsc_numObjectsDestroyed++;
43878f1b9b4SToby Isaac   /* Dynamically enlarge logging structures */
43978f1b9b4SToby Isaac   /* Record the destruction action */
44078f1b9b4SToby Isaac   if (def->petsc_logActions) {
44178f1b9b4SToby Isaac     Action new_action;
44278f1b9b4SToby Isaac 
44378f1b9b4SToby Isaac     PetscCall(PetscTime(&new_action.time));
44478f1b9b4SToby Isaac     new_action.time -= petsc_BaseTime;
44578f1b9b4SToby Isaac     new_action.event   = -1;
44678f1b9b4SToby Isaac     new_action.action  = PETSC_LOG_ACTION_DESTROY;
44778f1b9b4SToby Isaac     new_action.classid = obj->classid;
44878f1b9b4SToby Isaac     new_action.id1     = obj->id;
44978f1b9b4SToby Isaac     new_action.id2     = -1;
45078f1b9b4SToby Isaac     new_action.id3     = -1;
45178f1b9b4SToby Isaac     new_action.flops   = petsc_TotalFlops;
45278f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&new_action.mem));
45378f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&new_action.maxmem));
45478f1b9b4SToby Isaac     PetscCall(PetscLogActionArrayPush(def->petsc_actions, new_action));
45578f1b9b4SToby Isaac   }
45678f1b9b4SToby Isaac   if (def->petsc_logObjects) {
45778f1b9b4SToby Isaac     Object *obj_entry = NULL;
45878f1b9b4SToby Isaac 
45978f1b9b4SToby Isaac     PetscAssert(obj->id >= 1, PETSC_COMM_SELF, PETSC_ERR_PLIB, "Object ids from PetscObjectNewId_Internal() start at 1");
46078f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayGetRef(def->petsc_objects, obj->id - 1, &obj_entry));
46178f1b9b4SToby Isaac     if (obj->name) PetscCall(PetscStrncpy(obj_entry->name, obj->name, 64));
46278f1b9b4SToby Isaac     obj_entry->obj = NULL;
46378f1b9b4SToby Isaac   }
46478f1b9b4SToby Isaac   PetscCall(PetscSpinlockUnlock(&def->lock));
46578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
46678f1b9b4SToby Isaac }
46778f1b9b4SToby Isaac 
46878f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerEventSync_Default(PetscLogHandler h, PetscLogEvent event, MPI_Comm comm)
46978f1b9b4SToby Isaac {
47078f1b9b4SToby Isaac   PetscLogState       state;
47178f1b9b4SToby Isaac   PetscLogEventInfo   event_info;
47278f1b9b4SToby Isaac   PetscEventPerfInfo *event_perf_info;
47378f1b9b4SToby Isaac   int                 stage;
47478f1b9b4SToby Isaac   PetscLogDouble      time = 0.0;
47578f1b9b4SToby Isaac 
47678f1b9b4SToby Isaac   PetscFunctionBegin;
47778f1b9b4SToby Isaac   if (!(PetscLogSyncOn) || comm == MPI_COMM_NULL) PetscFunctionReturn(PETSC_SUCCESS);
47878f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
47978f1b9b4SToby Isaac   PetscCall(PetscLogStateEventGetInfo(state, event, &event_info));
48078f1b9b4SToby Isaac   if (!event_info.collective) PetscFunctionReturn(PETSC_SUCCESS);
48178f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &stage));
482*dff009beSToby Isaac   PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info));
48378f1b9b4SToby Isaac   if (event_perf_info->depth > 0) PetscFunctionReturn(PETSC_SUCCESS);
48478f1b9b4SToby Isaac 
48578f1b9b4SToby Isaac   PetscCall(PetscTimeSubtract(&time));
48678f1b9b4SToby Isaac   PetscCallMPI(MPI_Barrier(comm));
48778f1b9b4SToby Isaac   PetscCall(PetscTimeAdd(&time));
48878f1b9b4SToby Isaac   event_perf_info->syncTime += time;
48978f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
49078f1b9b4SToby Isaac }
49178f1b9b4SToby Isaac 
49278f1b9b4SToby Isaac static PetscErrorCode PetscLogGetStageEventPerfInfo_threaded(PetscLogHandler_Default def, PetscLogStage stage, PetscLogEvent event, PetscEventPerfInfo **eventInfo)
49378f1b9b4SToby Isaac {
49478f1b9b4SToby Isaac   PetscEventPerfInfo *leventInfo = NULL;
49578f1b9b4SToby Isaac   PetscHashIJKKey     key;
49678f1b9b4SToby Isaac 
49778f1b9b4SToby Isaac   PetscFunctionBegin;
49878f1b9b4SToby Isaac 
49978f1b9b4SToby Isaac #if PetscDefined(HAVE_THREADSAFETY)
50078f1b9b4SToby Isaac   key.i = PetscLogGetTid();
50178f1b9b4SToby Isaac #else
50278f1b9b4SToby Isaac   key.i = 0;
50378f1b9b4SToby Isaac #endif
50478f1b9b4SToby Isaac   key.j = stage;
50578f1b9b4SToby Isaac   key.k = event;
50678f1b9b4SToby Isaac   PetscCall(PetscSpinlockLock(&def->lock));
50778f1b9b4SToby Isaac   PetscCall(PetscHMapEventGet(def->eventInfoMap_th, key, &leventInfo));
50878f1b9b4SToby Isaac   if (!leventInfo) {
50978f1b9b4SToby Isaac     PetscCall(PetscNew(&leventInfo));
51078f1b9b4SToby Isaac     leventInfo->id = event;
51178f1b9b4SToby Isaac     PetscCall(PetscHMapEventSet(def->eventInfoMap_th, key, leventInfo));
51278f1b9b4SToby Isaac   }
51378f1b9b4SToby Isaac   PetscCall(PetscSpinlockUnlock(&def->lock));
51478f1b9b4SToby Isaac   *eventInfo = leventInfo;
51578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
51678f1b9b4SToby Isaac }
51778f1b9b4SToby Isaac 
51878f1b9b4SToby Isaac #if defined(PETSC_HAVE_CUDA)
51978f1b9b4SToby Isaac   #include <nvToolsExt.h>
52078f1b9b4SToby Isaac #endif
52178f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerEventBegin_Default(PetscLogHandler h, PetscLogEvent event, PetscObject o1, PetscObject o2, PetscObject o3, PetscObject o4)
52278f1b9b4SToby Isaac {
52378f1b9b4SToby Isaac   PetscLogHandler_Default def             = (PetscLogHandler_Default)h->data;
52478f1b9b4SToby Isaac   PetscEventPerfInfo     *event_perf_info = NULL;
52578f1b9b4SToby Isaac   PetscLogEventInfo       event_info;
52678f1b9b4SToby Isaac   PetscLogDouble          time;
52778f1b9b4SToby Isaac   PetscLogState           state;
52878f1b9b4SToby Isaac   PetscLogStage           stage;
52978f1b9b4SToby Isaac 
53078f1b9b4SToby Isaac   PetscFunctionBegin;
53178f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
53278f1b9b4SToby Isaac   /* Synchronization */
53378f1b9b4SToby Isaac   PetscCall(PetscLogHandlerEventSync_Default(h, event, PetscObjectComm(o1)));
53478f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &stage));
53578f1b9b4SToby Isaac   if (def->pause_depth > 0) stage = 0; // in pause-mode, all events run on the main stage
536461318ebSToby Isaac   if (PetscDefined(HAVE_THREADSAFETY) || def->use_threadsafe) {
53778f1b9b4SToby Isaac     PetscCall(PetscLogGetStageEventPerfInfo_threaded(def, stage, event, &event_perf_info));
53878f1b9b4SToby Isaac     if (event_perf_info->depth == 0) { PetscCall(PetscEventPerfInfoInit(event_perf_info)); }
53978f1b9b4SToby Isaac   } else {
540*dff009beSToby Isaac     PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info));
54178f1b9b4SToby Isaac   }
54278f1b9b4SToby Isaac   PetscCheck(event_perf_info->depth >= 0, PETSC_COMM_SELF, PETSC_ERR_ARG_WRONGSTATE, "Trying to begin a paused event, this is not allowed");
54378f1b9b4SToby Isaac   event_perf_info->depth++;
54478f1b9b4SToby Isaac   /* Check for double counting */
54578f1b9b4SToby Isaac   if (event_perf_info->depth > 1) PetscFunctionReturn(PETSC_SUCCESS);
54678f1b9b4SToby Isaac #if defined(PETSC_HAVE_CUDA)
54778f1b9b4SToby Isaac   if (PetscDeviceInitialized(PETSC_DEVICE_CUDA)) {
54878f1b9b4SToby Isaac     PetscLogEventInfo event_reg_info;
54978f1b9b4SToby Isaac 
55078f1b9b4SToby Isaac     PetscCall(PetscLogStateEventGetInfo(state, event, &event_reg_info));
55178f1b9b4SToby Isaac     nvtxRangePushA(event_reg_info.name);
55278f1b9b4SToby Isaac   }
55378f1b9b4SToby Isaac #endif
55478f1b9b4SToby Isaac   PetscCall(PetscLogStateEventGetInfo(state, event, &event_info));
55578f1b9b4SToby Isaac   /* Log the performance info */
55678f1b9b4SToby Isaac   event_perf_info->count++;
55778f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
55878f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoTic(event_perf_info, time, PetscLogMemory, (int)event));
55978f1b9b4SToby Isaac   if (def->petsc_logActions) {
56078f1b9b4SToby Isaac     PetscLogDouble curTime;
56178f1b9b4SToby Isaac     Action         new_action;
56278f1b9b4SToby Isaac 
56378f1b9b4SToby Isaac     PetscCall(PetscTime(&curTime));
56478f1b9b4SToby Isaac     new_action.time    = curTime - petsc_BaseTime;
56578f1b9b4SToby Isaac     new_action.action  = PETSC_LOG_ACTION_BEGIN;
56678f1b9b4SToby Isaac     new_action.event   = event;
56778f1b9b4SToby Isaac     new_action.classid = event_info.classid;
56878f1b9b4SToby Isaac     new_action.id1     = o1 ? o1->id : -1;
56978f1b9b4SToby Isaac     new_action.id2     = o2 ? o2->id : -1;
57078f1b9b4SToby Isaac     new_action.id3     = o3 ? o3->id : -1;
57178f1b9b4SToby Isaac     new_action.flops   = petsc_TotalFlops;
57278f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&new_action.mem));
57378f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&new_action.maxmem));
57478f1b9b4SToby Isaac     PetscCall(PetscLogActionArrayPush(def->petsc_actions, new_action));
57578f1b9b4SToby Isaac   }
57678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
57778f1b9b4SToby Isaac }
57878f1b9b4SToby Isaac 
57978f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerEventEnd_Default(PetscLogHandler h, PetscLogEvent event, PetscObject o1, PetscObject o2, PetscObject o3, PetscObject o4)
58078f1b9b4SToby Isaac {
58178f1b9b4SToby Isaac   PetscLogHandler_Default def             = (PetscLogHandler_Default)h->data;
58278f1b9b4SToby Isaac   PetscEventPerfInfo     *event_perf_info = NULL;
58378f1b9b4SToby Isaac   PetscLogDouble          time;
58478f1b9b4SToby Isaac   PetscLogState           state;
58578f1b9b4SToby Isaac   int                     stage;
58678f1b9b4SToby Isaac 
58778f1b9b4SToby Isaac   PetscFunctionBegin;
58878f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
58978f1b9b4SToby Isaac   if (def->petsc_logActions) {
59078f1b9b4SToby Isaac     PetscLogEventInfo event_info;
59178f1b9b4SToby Isaac     PetscLogDouble    curTime;
59278f1b9b4SToby Isaac     Action            new_action;
59378f1b9b4SToby Isaac 
59478f1b9b4SToby Isaac     PetscCall(PetscLogStateEventGetInfo(state, event, &event_info));
59578f1b9b4SToby Isaac     PetscCall(PetscTime(&curTime));
59678f1b9b4SToby Isaac     new_action.time    = curTime - petsc_BaseTime;
59778f1b9b4SToby Isaac     new_action.action  = PETSC_LOG_ACTION_END;
59878f1b9b4SToby Isaac     new_action.event   = event;
59978f1b9b4SToby Isaac     new_action.classid = event_info.classid;
60078f1b9b4SToby Isaac     new_action.id1     = o1 ? o1->id : -1;
60178f1b9b4SToby Isaac     new_action.id2     = o2 ? o2->id : -2;
60278f1b9b4SToby Isaac     new_action.id3     = o3 ? o3->id : -3;
60378f1b9b4SToby Isaac     new_action.flops   = petsc_TotalFlops;
60478f1b9b4SToby Isaac     PetscCall(PetscMallocGetCurrentUsage(&new_action.mem));
60578f1b9b4SToby Isaac     PetscCall(PetscMallocGetMaximumUsage(&new_action.maxmem));
60678f1b9b4SToby Isaac     PetscCall(PetscLogActionArrayPush(def->petsc_actions, new_action));
60778f1b9b4SToby Isaac   }
60878f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &stage));
60978f1b9b4SToby Isaac   if (def->pause_depth > 0) stage = 0; // all events run on the main stage in pause-mode
610461318ebSToby Isaac   if (PetscDefined(HAVE_THREADSAFETY) || def->use_threadsafe) {
61178f1b9b4SToby Isaac     PetscCall(PetscLogGetStageEventPerfInfo_threaded(def, stage, event, &event_perf_info));
61278f1b9b4SToby Isaac   } else {
613*dff009beSToby Isaac     PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info));
61478f1b9b4SToby Isaac   }
61578f1b9b4SToby Isaac   PetscCheck(event_perf_info->depth > 0, PETSC_COMM_SELF, PETSC_ERR_ARG_WRONGSTATE, "Trying to end paused event, not allowed");
61678f1b9b4SToby Isaac   event_perf_info->depth--;
61778f1b9b4SToby Isaac   /* Check for double counting */
61878f1b9b4SToby Isaac   if (event_perf_info->depth > 0) PetscFunctionReturn(PETSC_SUCCESS);
61978f1b9b4SToby Isaac   else PetscCheck(event_perf_info->depth == 0, PETSC_COMM_SELF, PETSC_ERR_ARG_WRONGSTATE, "Logging event had unbalanced begin/end pairs");
62078f1b9b4SToby Isaac 
62178f1b9b4SToby Isaac   /* Log performance info */
62278f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
62378f1b9b4SToby Isaac   PetscCall(PetscEventPerfInfoToc(event_perf_info, time, PetscLogMemory, (int)event));
624461318ebSToby Isaac   if (PetscDefined(HAVE_THREADSAFETY) || def->use_threadsafe) {
62578f1b9b4SToby Isaac     PetscEventPerfInfo *event_perf_info_global;
62678f1b9b4SToby Isaac     PetscCall(PetscSpinlockLock(&def->lock));
627*dff009beSToby Isaac     PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info_global));
62878f1b9b4SToby Isaac     PetscCall(PetscEventPerfInfoAdd_Internal(event_perf_info, event_perf_info_global));
62978f1b9b4SToby Isaac     PetscCall(PetscSpinlockUnlock(&def->lock));
63078f1b9b4SToby Isaac   }
63178f1b9b4SToby Isaac #if defined(PETSC_HAVE_CUDA)
63278f1b9b4SToby Isaac   if (PetscDeviceInitialized(PETSC_DEVICE_CUDA)) nvtxRangePop();
63378f1b9b4SToby Isaac #endif
63478f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
63578f1b9b4SToby Isaac }
63678f1b9b4SToby Isaac 
637*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerEventDeactivatePush_Default(PetscLogHandler h, PetscLogStage stage, PetscLogEvent event)
63878f1b9b4SToby Isaac {
63978f1b9b4SToby Isaac   PetscEventPerfInfo *event_perf_info;
64078f1b9b4SToby Isaac 
64178f1b9b4SToby Isaac   PetscFunctionBegin;
64278f1b9b4SToby Isaac   if (stage < 0) PetscCall(PetscLogStateGetCurrentStage(h->state, &stage));
643*dff009beSToby Isaac   PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info));
64478f1b9b4SToby Isaac   event_perf_info->depth++;
64578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
64678f1b9b4SToby Isaac }
64778f1b9b4SToby Isaac 
648*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerEventDeactivatePop_Default(PetscLogHandler h, PetscLogStage stage, PetscLogEvent event)
64978f1b9b4SToby Isaac {
65078f1b9b4SToby Isaac   PetscEventPerfInfo *event_perf_info;
65178f1b9b4SToby Isaac 
65278f1b9b4SToby Isaac   PetscFunctionBegin;
65378f1b9b4SToby Isaac   if (stage < 0) PetscCall(PetscLogStateGetCurrentStage(h->state, &stage));
654*dff009beSToby Isaac   PetscCall(PetscLogHandlerGetEventPerfInfo_Default(h, stage, event, &event_perf_info));
65578f1b9b4SToby Isaac   event_perf_info->depth--;
65678f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
65778f1b9b4SToby Isaac }
65878f1b9b4SToby Isaac 
659*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerEventsPause_Default(PetscLogHandler h)
66078f1b9b4SToby Isaac {
66178f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
66278f1b9b4SToby Isaac   PetscLogDouble          time;
66378f1b9b4SToby Isaac   PetscInt                num_stages;
66478f1b9b4SToby Isaac 
66578f1b9b4SToby Isaac   PetscFunctionBegin;
66678f1b9b4SToby Isaac   if (def->pause_depth++ > 0) PetscFunctionReturn(PETSC_SUCCESS);
66778f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayGetSize(def->stages, &num_stages, NULL));
66878f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
66978f1b9b4SToby Isaac   for (PetscInt stage = 0; stage < num_stages; stage++) {
67078f1b9b4SToby Isaac     PetscStagePerf *stage_info = NULL;
67178f1b9b4SToby Isaac     PetscInt        num_events;
67278f1b9b4SToby Isaac 
67378f1b9b4SToby Isaac     PetscCall(PetscLogStageInfoArrayGetRef(def->stages, stage, &stage_info));
67478f1b9b4SToby Isaac     PetscCall(PetscLogEventPerfArrayGetSize(stage_info->eventLog, &num_events, NULL));
67578f1b9b4SToby Isaac     for (PetscInt event = 0; event < num_events; event++) {
67678f1b9b4SToby Isaac       PetscEventPerfInfo *event_info = NULL;
67778f1b9b4SToby Isaac       PetscCall(PetscLogEventPerfArrayGetRef(stage_info->eventLog, event, &event_info));
67878f1b9b4SToby Isaac       if (event_info->depth > 0) {
67978f1b9b4SToby Isaac         event_info->depth *= -1;
68078f1b9b4SToby Isaac         PetscCall(PetscEventPerfInfoPause(event_info, time, PetscLogMemory, event));
68178f1b9b4SToby Isaac       }
68278f1b9b4SToby Isaac     }
68378f1b9b4SToby Isaac     if (stage > 0 && stage_info->perfInfo.depth > 0) {
68478f1b9b4SToby Isaac       stage_info->perfInfo.depth *= -1;
68578f1b9b4SToby Isaac       PetscCall(PetscEventPerfInfoPause(&stage_info->perfInfo, time, PetscLogMemory, -(stage + 2)));
68678f1b9b4SToby Isaac     }
68778f1b9b4SToby Isaac   }
68878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
68978f1b9b4SToby Isaac }
69078f1b9b4SToby Isaac 
691*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerEventsResume_Default(PetscLogHandler h)
69278f1b9b4SToby Isaac {
69378f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
69478f1b9b4SToby Isaac   PetscLogDouble          time;
69578f1b9b4SToby Isaac   PetscInt                num_stages;
69678f1b9b4SToby Isaac 
69778f1b9b4SToby Isaac   PetscFunctionBegin;
69878f1b9b4SToby Isaac   if (--def->pause_depth > 0) PetscFunctionReturn(PETSC_SUCCESS);
69978f1b9b4SToby Isaac   PetscCall(PetscLogStageInfoArrayGetSize(def->stages, &num_stages, NULL));
70078f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
70178f1b9b4SToby Isaac   for (PetscInt stage = 0; stage < num_stages; stage++) {
70278f1b9b4SToby Isaac     PetscStagePerf *stage_info = NULL;
70378f1b9b4SToby Isaac     PetscInt        num_events;
70478f1b9b4SToby Isaac 
70578f1b9b4SToby Isaac     PetscCall(PetscLogStageInfoArrayGetRef(def->stages, stage, &stage_info));
70678f1b9b4SToby Isaac     PetscCall(PetscLogEventPerfArrayGetSize(stage_info->eventLog, &num_events, NULL));
70778f1b9b4SToby Isaac     for (PetscInt event = 0; event < num_events; event++) {
70878f1b9b4SToby Isaac       PetscEventPerfInfo *event_info = NULL;
70978f1b9b4SToby Isaac       PetscCall(PetscLogEventPerfArrayGetRef(stage_info->eventLog, event, &event_info));
71078f1b9b4SToby Isaac       if (event_info->depth < 0) {
71178f1b9b4SToby Isaac         event_info->depth *= -1;
71278f1b9b4SToby Isaac         PetscCall(PetscEventPerfInfoResume(event_info, time, PetscLogMemory, event));
71378f1b9b4SToby Isaac       }
71478f1b9b4SToby Isaac     }
71578f1b9b4SToby Isaac     if (stage > 0 && stage_info->perfInfo.depth < 0) {
71678f1b9b4SToby Isaac       stage_info->perfInfo.depth *= -1;
71778f1b9b4SToby Isaac       PetscCall(PetscEventPerfInfoResume(&stage_info->perfInfo, time, PetscLogMemory, -(stage + 2)));
71878f1b9b4SToby Isaac     }
71978f1b9b4SToby Isaac   }
72078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
72178f1b9b4SToby Isaac }
72278f1b9b4SToby Isaac 
72378f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerStagePush_Default(PetscLogHandler h, PetscLogStage new_stage)
72478f1b9b4SToby Isaac {
72578f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
72678f1b9b4SToby Isaac   PetscLogDouble          time;
72778f1b9b4SToby Isaac   PetscLogState           state;
72878f1b9b4SToby Isaac   PetscLogStage           current_stage;
72978f1b9b4SToby Isaac   PetscStagePerf         *new_stage_info;
73078f1b9b4SToby Isaac 
73178f1b9b4SToby Isaac   PetscFunctionBegin;
73278f1b9b4SToby Isaac   if (def->pause_depth > 0) PetscFunctionReturn(PETSC_SUCCESS);
73378f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
73478f1b9b4SToby Isaac   current_stage = state->current_stage;
73578f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(h, new_stage, &new_stage_info));
73678f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
73778f1b9b4SToby Isaac 
73878f1b9b4SToby Isaac   /* Record flops/time of previous stage */
73978f1b9b4SToby Isaac   if (current_stage >= 0) {
74078f1b9b4SToby Isaac     if (PetscBTLookup(state->active, current_stage)) {
74178f1b9b4SToby Isaac       PetscStagePerf *current_stage_info;
74278f1b9b4SToby Isaac       PetscCall(PetscLogHandlerDefaultGetStageInfo(h, current_stage, &current_stage_info));
74378f1b9b4SToby Isaac       PetscCall(PetscEventPerfInfoToc(&current_stage_info->perfInfo, time, PetscLogMemory, (int)-(current_stage + 2)));
74478f1b9b4SToby Isaac     }
74578f1b9b4SToby Isaac   }
74678f1b9b4SToby Isaac   new_stage_info->used = PETSC_TRUE;
74778f1b9b4SToby Isaac   new_stage_info->perfInfo.count++;
74878f1b9b4SToby Isaac   new_stage_info->perfInfo.depth++;
74978f1b9b4SToby Isaac   /* Subtract current quantities so that we obtain the difference when we pop */
75078f1b9b4SToby Isaac   if (PetscBTLookup(state->active, new_stage)) PetscCall(PetscEventPerfInfoTic(&new_stage_info->perfInfo, time, PetscLogMemory, (int)-(new_stage + 2)));
75178f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
75278f1b9b4SToby Isaac }
75378f1b9b4SToby Isaac 
75478f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerStagePop_Default(PetscLogHandler h, PetscLogStage old_stage)
75578f1b9b4SToby Isaac {
75678f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)h->data;
75778f1b9b4SToby Isaac   PetscLogStage           current_stage;
75878f1b9b4SToby Isaac   PetscStagePerf         *old_stage_info;
75978f1b9b4SToby Isaac   PetscLogState           state;
76078f1b9b4SToby Isaac   PetscLogDouble          time;
76178f1b9b4SToby Isaac 
76278f1b9b4SToby Isaac   PetscFunctionBegin;
76378f1b9b4SToby Isaac   if (def->pause_depth > 0) PetscFunctionReturn(PETSC_SUCCESS);
76478f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(h, &state));
76578f1b9b4SToby Isaac   current_stage = state->current_stage;
76678f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(h, old_stage, &old_stage_info));
76778f1b9b4SToby Isaac   PetscCall(PetscTime(&time));
76878f1b9b4SToby Isaac   old_stage_info->perfInfo.depth--;
76978f1b9b4SToby Isaac   if (PetscBTLookup(state->active, old_stage)) { PetscCall(PetscEventPerfInfoToc(&old_stage_info->perfInfo, time, PetscLogMemory, (int)-(old_stage + 2))); }
77078f1b9b4SToby Isaac   if (current_stage >= 0) {
77178f1b9b4SToby Isaac     if (PetscBTLookup(state->active, current_stage)) {
77278f1b9b4SToby Isaac       PetscStagePerf *current_stage_info;
77378f1b9b4SToby Isaac       PetscCall(PetscLogHandlerDefaultGetStageInfo(h, current_stage, &current_stage_info));
77478f1b9b4SToby Isaac       PetscCall(PetscEventPerfInfoTic(&current_stage_info->perfInfo, time, PetscLogMemory, (int)-(current_stage + 2)));
77578f1b9b4SToby Isaac     }
77678f1b9b4SToby Isaac   }
77778f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
77878f1b9b4SToby Isaac }
77978f1b9b4SToby Isaac 
780*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerStageSetVisible_Default(PetscLogHandler h, PetscLogStage stage, PetscBool is_visible)
78178f1b9b4SToby Isaac {
78278f1b9b4SToby Isaac   PetscStagePerf *stage_info;
78378f1b9b4SToby Isaac 
78478f1b9b4SToby Isaac   PetscFunctionBegin;
78578f1b9b4SToby Isaac   if (stage < 0) PetscCall(PetscLogStateGetCurrentStage(h->state, &stage));
78678f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(h, stage, &stage_info));
78778f1b9b4SToby Isaac   stage_info->perfInfo.visible = is_visible;
78878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
78978f1b9b4SToby Isaac }
79078f1b9b4SToby Isaac 
791*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerStageGetVisible_Default(PetscLogHandler h, PetscLogStage stage, PetscBool *is_visible)
79278f1b9b4SToby Isaac {
79378f1b9b4SToby Isaac   PetscStagePerf *stage_info;
79478f1b9b4SToby Isaac 
79578f1b9b4SToby Isaac   PetscFunctionBegin;
79678f1b9b4SToby Isaac   if (stage < 0) PetscCall(PetscLogStateGetCurrentStage(h->state, &stage));
79778f1b9b4SToby Isaac   PetscCall(PetscLogHandlerDefaultGetStageInfo(h, stage, &stage_info));
79878f1b9b4SToby Isaac   *is_visible = stage_info->perfInfo.visible;
79978f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
80078f1b9b4SToby Isaac }
80178f1b9b4SToby Isaac 
802*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerSetLogActions_Default(PetscLogHandler handler, PetscBool flag)
80378f1b9b4SToby Isaac {
80478f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
80578f1b9b4SToby Isaac 
80678f1b9b4SToby Isaac   PetscFunctionBegin;
80778f1b9b4SToby Isaac   def->petsc_logActions = flag;
80878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
80978f1b9b4SToby Isaac }
81078f1b9b4SToby Isaac 
811*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerSetLogObjects_Default(PetscLogHandler handler, PetscBool flag)
81278f1b9b4SToby Isaac {
81378f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
81478f1b9b4SToby Isaac 
81578f1b9b4SToby Isaac   PetscFunctionBegin;
81678f1b9b4SToby Isaac   def->petsc_logObjects = flag;
81778f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
81878f1b9b4SToby Isaac }
81978f1b9b4SToby Isaac 
820*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerLogObjectState_Default(PetscLogHandler handler, PetscObject obj, const char format[], va_list Argp)
82178f1b9b4SToby Isaac {
82278f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
82378f1b9b4SToby Isaac   size_t                  fullLength;
82478f1b9b4SToby Isaac 
82578f1b9b4SToby Isaac   PetscFunctionBegin;
82678f1b9b4SToby Isaac   if (def->petsc_logObjects) {
82778f1b9b4SToby Isaac     Object *obj_entry = NULL;
82878f1b9b4SToby Isaac 
82978f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayGetRef(def->petsc_objects, obj->id - 1, &obj_entry));
83078f1b9b4SToby Isaac     PetscCall(PetscVSNPrintf(obj_entry->info, 64, format, &fullLength, Argp));
83178f1b9b4SToby Isaac   }
83278f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
83378f1b9b4SToby Isaac }
83478f1b9b4SToby Isaac 
835*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerGetNumObjects_Default(PetscLogHandler handler, PetscInt *num_objects)
83678f1b9b4SToby Isaac {
83778f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
83878f1b9b4SToby Isaac 
83978f1b9b4SToby Isaac   PetscFunctionBegin;
84078f1b9b4SToby Isaac   PetscCall(PetscLogObjectArrayGetSize(def->petsc_objects, num_objects, NULL));
84178f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
84278f1b9b4SToby Isaac }
84378f1b9b4SToby Isaac 
844*dff009beSToby Isaac static PetscErrorCode PetscLogHandlerDump_Default(PetscLogHandler handler, const char sname[])
84578f1b9b4SToby Isaac {
84678f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
84778f1b9b4SToby Isaac   FILE                   *fd;
84878f1b9b4SToby Isaac   char                    file[PETSC_MAX_PATH_LEN], fname[PETSC_MAX_PATH_LEN];
84978f1b9b4SToby Isaac   PetscLogDouble          flops, _TotalTime;
85078f1b9b4SToby Isaac   PetscMPIInt             rank;
85178f1b9b4SToby Isaac   int                     curStage;
85278f1b9b4SToby Isaac   PetscLogState           state;
85378f1b9b4SToby Isaac   PetscInt                num_events;
85478f1b9b4SToby Isaac   PetscLogEvent           event;
85578f1b9b4SToby Isaac 
85678f1b9b4SToby Isaac   PetscFunctionBegin;
85778f1b9b4SToby Isaac   /* Calculate the total elapsed time */
85878f1b9b4SToby Isaac   PetscCall(PetscTime(&_TotalTime));
85978f1b9b4SToby Isaac   _TotalTime -= petsc_BaseTime;
86078f1b9b4SToby Isaac   /* Open log file */
86178f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_rank(PetscObjectComm((PetscObject)handler), &rank));
86278f1b9b4SToby Isaac   PetscCall(PetscSNPrintf(file, PETSC_STATIC_ARRAY_LENGTH(file), "%s.%d", sname && sname[0] ? sname : "Log", rank));
86378f1b9b4SToby Isaac   PetscCall(PetscFixFilename(file, fname));
86478f1b9b4SToby Isaac   PetscCall(PetscFOpen(PETSC_COMM_SELF, fname, "w", &fd));
86578f1b9b4SToby Isaac   PetscCheck(!(rank == 0) || !(!fd), PETSC_COMM_SELF, PETSC_ERR_FILE_OPEN, "Cannot open file: %s", fname);
86678f1b9b4SToby Isaac   /* Output totals */
86778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Total Flop %14e %16.8e\n", petsc_TotalFlops, _TotalTime));
86878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Clock Resolution %g\n", 0.0));
86978f1b9b4SToby Isaac   /* Output actions */
87078f1b9b4SToby Isaac   if (def->petsc_logActions) {
87178f1b9b4SToby Isaac     PetscInt num_actions;
87278f1b9b4SToby Isaac     PetscCall(PetscLogActionArrayGetSize(def->petsc_actions, &num_actions, NULL));
87378f1b9b4SToby Isaac     PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Actions accomplished %d\n", (int)num_actions));
87478f1b9b4SToby Isaac     for (int a = 0; a < num_actions; a++) {
87578f1b9b4SToby Isaac       Action *action;
87678f1b9b4SToby Isaac 
87778f1b9b4SToby Isaac       PetscCall(PetscLogActionArrayGetRef(def->petsc_actions, a, &action));
87878f1b9b4SToby Isaac       PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "%g %d %d %d %d %d %d %g %g %g\n", action->time, action->action, (int)action->event, (int)action->classid, action->id1, action->id2, action->id3, action->flops, action->mem, action->maxmem));
87978f1b9b4SToby Isaac     }
88078f1b9b4SToby Isaac   }
88178f1b9b4SToby Isaac   /* Output objects */
88278f1b9b4SToby Isaac   if (def->petsc_logObjects) {
88378f1b9b4SToby Isaac     PetscInt num_objects;
88478f1b9b4SToby Isaac 
88578f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayGetSize(def->petsc_objects, &num_objects, NULL));
88678f1b9b4SToby Isaac     PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Objects created %d destroyed %d\n", def->petsc_numObjectsCreated, def->petsc_numObjectsDestroyed));
88778f1b9b4SToby Isaac     for (int o = 0; o < num_objects; o++) {
88878f1b9b4SToby Isaac       Object *object = NULL;
88978f1b9b4SToby Isaac 
89078f1b9b4SToby Isaac       PetscCall(PetscLogObjectArrayGetRef(def->petsc_objects, o, &object));
89178f1b9b4SToby Isaac       if (object->parent != -1) continue; // object with this id wasn't logged, probably a PetscLogHandler
89278f1b9b4SToby Isaac       PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Parent ID: %d Memory: %d\n", object->parent, (int)object->mem));
89378f1b9b4SToby Isaac       if (!object->name[0]) {
89478f1b9b4SToby Isaac         PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "No Name\n"));
89578f1b9b4SToby Isaac       } else {
89678f1b9b4SToby Isaac         PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Name: %s\n", object->name));
89778f1b9b4SToby Isaac       }
89878f1b9b4SToby Isaac       if (!object->info[0]) {
89978f1b9b4SToby Isaac         PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "No Info\n"));
90078f1b9b4SToby Isaac       } else {
90178f1b9b4SToby Isaac         PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Info: %s\n", object->info));
90278f1b9b4SToby Isaac       }
90378f1b9b4SToby Isaac     }
90478f1b9b4SToby Isaac   }
90578f1b9b4SToby Isaac   /* Output events */
90678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "Event log:\n"));
90778f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(handler, &state));
90878f1b9b4SToby Isaac   PetscCall(PetscLogStateGetNumEvents(state, &num_events));
90978f1b9b4SToby Isaac   PetscCall(PetscLogStateGetCurrentStage(state, &curStage));
91078f1b9b4SToby Isaac   for (event = 0; event < num_events; event++) {
91178f1b9b4SToby Isaac     PetscEventPerfInfo *event_info;
91278f1b9b4SToby Isaac 
913*dff009beSToby Isaac     PetscCall(PetscLogHandlerGetEventPerfInfo_Default(handler, curStage, event, &event_info));
91478f1b9b4SToby Isaac     if (event_info->time != 0.0) flops = event_info->flops / event_info->time;
91578f1b9b4SToby Isaac     else flops = 0.0;
91678f1b9b4SToby Isaac     PetscCall(PetscFPrintf(PETSC_COMM_SELF, fd, "%d %16d %16g %16g %16g\n", event, event_info->count, event_info->flops, event_info->time, flops));
91778f1b9b4SToby Isaac   }
91878f1b9b4SToby Isaac   PetscCall(PetscFClose(PETSC_COMM_SELF, fd));
91978f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
92078f1b9b4SToby Isaac }
92178f1b9b4SToby Isaac 
92278f1b9b4SToby Isaac /*
92378f1b9b4SToby Isaac   PetscLogView_Detailed - Each process prints the times for its own events
92478f1b9b4SToby Isaac 
92578f1b9b4SToby Isaac */
92678f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerView_Default_Detailed(PetscLogHandler handler, PetscViewer viewer)
92778f1b9b4SToby Isaac {
92878f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
92978f1b9b4SToby Isaac   PetscLogDouble          locTotalTime, numRed, maxMem;
93078f1b9b4SToby Isaac   PetscInt                numStages, numEvents;
93178f1b9b4SToby Isaac   MPI_Comm                comm = PetscObjectComm((PetscObject)viewer);
93278f1b9b4SToby Isaac   PetscMPIInt             rank, size;
93378f1b9b4SToby Isaac   PetscLogGlobalNames     global_stages, global_events;
93478f1b9b4SToby Isaac   PetscLogState           state;
93578f1b9b4SToby Isaac   PetscEventPerfInfo      zero_info;
93678f1b9b4SToby Isaac 
93778f1b9b4SToby Isaac   PetscFunctionBegin;
93878f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(handler, &state));
93978f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_size(comm, &size));
94078f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_rank(comm, &rank));
94178f1b9b4SToby Isaac   /* Must preserve reduction count before we go on */
94278f1b9b4SToby Isaac   numRed = petsc_allreduce_ct + petsc_gather_ct + petsc_scatter_ct;
94378f1b9b4SToby Isaac   /* Get the total elapsed time */
94478f1b9b4SToby Isaac   PetscCall(PetscTime(&locTotalTime));
94578f1b9b4SToby Isaac   locTotalTime -= petsc_BaseTime;
94678f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "size = %d\n", size));
94778f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalTimes = {}\n"));
94878f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalMessages = {}\n"));
94978f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalMessageLens = {}\n"));
95078f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalReductions = {}\n"));
95178f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalFlop = {}\n"));
95278f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalObjects = {}\n"));
95378f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "LocalMemory = {}\n"));
95478f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalStageNames(comm, state->registry, &global_stages));
95578f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalEventNames(comm, state->registry, &global_events));
95678f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_stages, NULL, &numStages));
95778f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_events, NULL, &numEvents));
95878f1b9b4SToby Isaac   PetscCall(PetscMemzero(&zero_info, sizeof(zero_info)));
95978f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "Stages = {}\n"));
96078f1b9b4SToby Isaac   for (PetscInt stage = 0; stage < numStages; stage++) {
96178f1b9b4SToby Isaac     PetscInt    stage_id;
96278f1b9b4SToby Isaac     const char *stage_name;
96378f1b9b4SToby Isaac 
96478f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
96578f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
96678f1b9b4SToby Isaac     PetscCall(PetscViewerASCIIPrintf(viewer, "Stages[\"%s\"] = {}\n", stage_name));
96778f1b9b4SToby Isaac     PetscCall(PetscViewerASCIIPrintf(viewer, "Stages[\"%s\"][\"summary\"] = {}\n", stage_name));
96878f1b9b4SToby Isaac     for (PetscInt event = 0; event < numEvents; event++) {
96978f1b9b4SToby Isaac       PetscEventPerfInfo *eventInfo = &zero_info;
97078f1b9b4SToby Isaac       PetscBool           is_zero   = PETSC_FALSE;
97178f1b9b4SToby Isaac       PetscInt            event_id;
97278f1b9b4SToby Isaac       const char         *event_name;
97378f1b9b4SToby Isaac 
97478f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_events, event, &event_id));
97578f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetName(global_events, event, &event_name));
976*dff009beSToby Isaac       if (event_id >= 0 && stage_id >= 0) PetscCall(PetscLogHandlerGetEventPerfInfo_Default(handler, stage_id, event_id, &eventInfo));
97778f1b9b4SToby Isaac       is_zero = eventInfo->count == 0 ? PETSC_TRUE : PETSC_FALSE;
97878f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(MPI_IN_PLACE, &is_zero, 1, MPIU_BOOL, MPI_LAND, comm));
97978f1b9b4SToby Isaac       if (!is_zero) { PetscCall(PetscViewerASCIIPrintf(viewer, "Stages[\"%s\"][\"%s\"] = {}\n", stage_name, event_name)); }
98078f1b9b4SToby Isaac     }
98178f1b9b4SToby Isaac   }
98278f1b9b4SToby Isaac   PetscCall(PetscMallocGetMaximumUsage(&maxMem));
98378f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPushSynchronized(viewer));
98478f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalTimes[%d] = %g\n", rank, locTotalTime));
98578f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalMessages[%d] = %g\n", rank, (petsc_irecv_ct + petsc_isend_ct + petsc_recv_ct + petsc_send_ct)));
98678f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalMessageLens[%d] = %g\n", rank, (petsc_irecv_len + petsc_isend_len + petsc_recv_len + petsc_send_len)));
98778f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalReductions[%d] = %g\n", rank, numRed));
98878f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalFlop[%d] = %g\n", rank, petsc_TotalFlops));
98978f1b9b4SToby Isaac   {
99078f1b9b4SToby Isaac     PetscInt num_objects;
99178f1b9b4SToby Isaac 
99278f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayGetSize(def->petsc_objects, &num_objects, NULL));
99378f1b9b4SToby Isaac     PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalObjects[%d] = %d\n", rank, (int)num_objects));
99478f1b9b4SToby Isaac   }
99578f1b9b4SToby Isaac   PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "LocalMemory[%d] = %g\n", rank, maxMem));
99678f1b9b4SToby Isaac   PetscCall(PetscViewerFlush(viewer));
99778f1b9b4SToby Isaac   for (PetscInt stage = 0; stage < numStages; stage++) {
99878f1b9b4SToby Isaac     PetscEventPerfInfo *stage_perf_info = &zero_info;
99978f1b9b4SToby Isaac     PetscInt            stage_id;
100078f1b9b4SToby Isaac     const char         *stage_name;
100178f1b9b4SToby Isaac 
100278f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
100378f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
100478f1b9b4SToby Isaac     if (stage_id >= 0) {
100578f1b9b4SToby Isaac       PetscStagePerf *stage_info;
100678f1b9b4SToby Isaac       PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage_id, &stage_info));
100778f1b9b4SToby Isaac       stage_perf_info = &stage_info->perfInfo;
100878f1b9b4SToby Isaac     }
100978f1b9b4SToby Isaac     PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "Stages[\"%s\"][\"summary\"][%d] = {\"time\" : %g, \"numMessages\" : %g, \"messageLength\" : %g, \"numReductions\" : %g, \"flop\" : %g}\n", stage_name, rank, stage_perf_info->time,
101078f1b9b4SToby Isaac                                                  stage_perf_info->numMessages, stage_perf_info->messageLength, stage_perf_info->numReductions, stage_perf_info->flops));
101178f1b9b4SToby Isaac     for (PetscInt event = 0; event < numEvents; event++) {
101278f1b9b4SToby Isaac       PetscEventPerfInfo *eventInfo = &zero_info;
101378f1b9b4SToby Isaac       PetscBool           is_zero   = PETSC_FALSE;
101478f1b9b4SToby Isaac       PetscInt            event_id;
101578f1b9b4SToby Isaac       const char         *event_name;
101678f1b9b4SToby Isaac 
101778f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_events, event, &event_id));
101878f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetName(global_events, event, &event_name));
1019*dff009beSToby Isaac       if (event_id >= 0 && stage_id >= 0) PetscCall(PetscLogHandlerGetEventPerfInfo_Default(handler, stage_id, event_id, &eventInfo));
102078f1b9b4SToby Isaac       is_zero = eventInfo->count == 0 ? PETSC_TRUE : PETSC_FALSE;
102178f1b9b4SToby Isaac       PetscCall(PetscMemcmp(eventInfo, &zero_info, sizeof(zero_info), &is_zero));
102278f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(MPI_IN_PLACE, &is_zero, 1, MPIU_BOOL, MPI_LAND, comm));
102378f1b9b4SToby Isaac       if (!is_zero) {
102478f1b9b4SToby Isaac         PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "Stages[\"%s\"][\"%s\"][%d] = {\"count\" : %d, \"time\" : %g, \"syncTime\" : %g, \"numMessages\" : %g, \"messageLength\" : %g, \"numReductions\" : %g, \"flop\" : %g", stage_name, event_name, rank,
102578f1b9b4SToby Isaac                                                      eventInfo->count, eventInfo->time, eventInfo->syncTime, eventInfo->numMessages, eventInfo->messageLength, eventInfo->numReductions, eventInfo->flops));
102678f1b9b4SToby Isaac         if (eventInfo->dof[0] >= 0.) {
102778f1b9b4SToby Isaac           PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ", \"dof\" : ["));
102878f1b9b4SToby Isaac           for (PetscInt d = 0; d < 8; ++d) {
102978f1b9b4SToby Isaac             if (d > 0) PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ", "));
103078f1b9b4SToby Isaac             PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "%g", eventInfo->dof[d]));
103178f1b9b4SToby Isaac           }
103278f1b9b4SToby Isaac           PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "]"));
103378f1b9b4SToby Isaac           PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ", \"error\" : ["));
103478f1b9b4SToby Isaac           for (PetscInt e = 0; e < 8; ++e) {
103578f1b9b4SToby Isaac             if (e > 0) PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ", "));
103678f1b9b4SToby Isaac             PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "%g", eventInfo->errors[e]));
103778f1b9b4SToby Isaac           }
103878f1b9b4SToby Isaac           PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "]"));
103978f1b9b4SToby Isaac         }
104078f1b9b4SToby Isaac       }
104178f1b9b4SToby Isaac       PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "}\n"));
104278f1b9b4SToby Isaac     }
104378f1b9b4SToby Isaac   }
104478f1b9b4SToby Isaac   PetscCall(PetscViewerFlush(viewer));
104578f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPopSynchronized(viewer));
104678f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_events));
104778f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_stages));
104878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
104978f1b9b4SToby Isaac }
105078f1b9b4SToby Isaac 
105178f1b9b4SToby Isaac /*
105278f1b9b4SToby Isaac   PetscLogView_CSV - Each process prints the times for its own events in Comma-Separated Value Format
105378f1b9b4SToby Isaac */
105478f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerView_Default_CSV(PetscLogHandler handler, PetscViewer viewer)
105578f1b9b4SToby Isaac {
105678f1b9b4SToby Isaac   PetscLogDouble      locTotalTime, maxMem;
105778f1b9b4SToby Isaac   PetscInt            numStages, numEvents, stage, event;
105878f1b9b4SToby Isaac   MPI_Comm            comm = PetscObjectComm((PetscObject)viewer);
105978f1b9b4SToby Isaac   PetscMPIInt         rank, size;
106078f1b9b4SToby Isaac   PetscLogGlobalNames global_stages, global_events;
106178f1b9b4SToby Isaac   PetscLogState       state;
106278f1b9b4SToby Isaac   PetscEventPerfInfo  zero_info;
106378f1b9b4SToby Isaac 
106478f1b9b4SToby Isaac   PetscFunctionBegin;
106578f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(handler, &state));
106678f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_size(comm, &size));
106778f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_rank(comm, &rank));
106878f1b9b4SToby Isaac   /* Must preserve reduction count before we go on */
106978f1b9b4SToby Isaac   /* Get the total elapsed time */
107078f1b9b4SToby Isaac   PetscCall(PetscTime(&locTotalTime));
107178f1b9b4SToby Isaac   locTotalTime -= petsc_BaseTime;
107278f1b9b4SToby Isaac   PetscCall(PetscMallocGetMaximumUsage(&maxMem));
107378f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalStageNames(comm, state->registry, &global_stages));
107478f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalEventNames(comm, state->registry, &global_events));
107578f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_stages, NULL, &numStages));
107678f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_events, NULL, &numEvents));
107778f1b9b4SToby Isaac   PetscCall(PetscMemzero(&zero_info, sizeof(zero_info)));
107878f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPushSynchronized(viewer));
107978f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPrintf(viewer, "Stage Name,Event Name,Rank,Count,Time,Num Messages,Message Length,Num Reductions,FLOP,dof0,dof1,dof2,dof3,dof4,dof5,dof6,dof7,e0,e1,e2,e3,e4,e5,e6,e7,%d\n", size));
108078f1b9b4SToby Isaac   PetscCall(PetscViewerFlush(viewer));
108178f1b9b4SToby Isaac   for (stage = 0; stage < numStages; stage++) {
108278f1b9b4SToby Isaac     PetscEventPerfInfo *stage_perf_info;
108378f1b9b4SToby Isaac     PetscInt            stage_id;
108478f1b9b4SToby Isaac     const char         *stage_name;
108578f1b9b4SToby Isaac 
108678f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
108778f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
108878f1b9b4SToby Isaac     stage_perf_info = &zero_info;
108978f1b9b4SToby Isaac     if (stage_id >= 0) {
109078f1b9b4SToby Isaac       PetscStagePerf *stage_info;
109178f1b9b4SToby Isaac       PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage_id, &stage_info));
109278f1b9b4SToby Isaac       stage_perf_info = &stage_info->perfInfo;
109378f1b9b4SToby Isaac     }
109478f1b9b4SToby Isaac     PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "%s,summary,%d,1,%g,%g,%g,%g,%g\n", stage_name, rank, stage_perf_info->time, stage_perf_info->numMessages, stage_perf_info->messageLength, stage_perf_info->numReductions, stage_perf_info->flops));
109578f1b9b4SToby Isaac     for (event = 0; event < numEvents; event++) {
109678f1b9b4SToby Isaac       PetscEventPerfInfo *eventInfo = &zero_info;
109778f1b9b4SToby Isaac       PetscBool           is_zero   = PETSC_FALSE;
109878f1b9b4SToby Isaac       PetscInt            event_id;
109978f1b9b4SToby Isaac       const char         *event_name;
110078f1b9b4SToby Isaac 
110178f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_events, event, &event_id));
110278f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetName(global_events, event, &event_name));
1103*dff009beSToby Isaac       if (event_id >= 0 && stage_id >= 0) PetscCall(PetscLogHandlerGetEventPerfInfo_Default(handler, stage_id, event_id, &eventInfo));
110478f1b9b4SToby Isaac       PetscCall(PetscMemcmp(eventInfo, &zero_info, sizeof(zero_info), &is_zero));
110578f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(MPI_IN_PLACE, &is_zero, 1, MPIU_BOOL, MPI_LAND, comm));
110678f1b9b4SToby Isaac       if (!is_zero) {
110778f1b9b4SToby Isaac         PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "%s,%s,%d,%d,%g,%g,%g,%g,%g", stage_name, event_name, rank, eventInfo->count, eventInfo->time, eventInfo->numMessages, eventInfo->messageLength, eventInfo->numReductions, eventInfo->flops));
110878f1b9b4SToby Isaac         if (eventInfo->dof[0] >= 0.) {
110978f1b9b4SToby Isaac           for (PetscInt d = 0; d < 8; ++d) PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ",%g", eventInfo->dof[d]));
111078f1b9b4SToby Isaac           for (PetscInt e = 0; e < 8; ++e) PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, ",%g", eventInfo->errors[e]));
111178f1b9b4SToby Isaac         }
111278f1b9b4SToby Isaac       }
111378f1b9b4SToby Isaac       PetscCall(PetscViewerASCIISynchronizedPrintf(viewer, "\n"));
111478f1b9b4SToby Isaac     }
111578f1b9b4SToby Isaac   }
111678f1b9b4SToby Isaac   PetscCall(PetscViewerFlush(viewer));
111778f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIPopSynchronized(viewer));
111878f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_stages));
111978f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_events));
112078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
112178f1b9b4SToby Isaac }
112278f1b9b4SToby Isaac 
112378f1b9b4SToby Isaac static PetscErrorCode PetscLogViewWarnSync(MPI_Comm comm, FILE *fd)
112478f1b9b4SToby Isaac {
112578f1b9b4SToby Isaac   PetscFunctionBegin;
112678f1b9b4SToby Isaac   if (!PetscLogSyncOn) PetscFunctionReturn(PETSC_SUCCESS);
112778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n\n"));
112878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n"));
112978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
113078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                       WARNING!!!                       #\n"));
113178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
113278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   This program was run with logging synchronization.   #\n"));
113378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   This option provides more meaningful imbalance       #\n"));
113478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   figures at the expense of slowing things down and    #\n"));
113578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   providing a distorted view of the overall runtime.   #\n"));
113678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
113778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n\n\n"));
113878f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
113978f1b9b4SToby Isaac }
114078f1b9b4SToby Isaac 
114178f1b9b4SToby Isaac static PetscErrorCode PetscLogViewWarnDebugging(MPI_Comm comm, FILE *fd)
114278f1b9b4SToby Isaac {
114378f1b9b4SToby Isaac   PetscFunctionBegin;
114478f1b9b4SToby Isaac   if (PetscDefined(USE_DEBUG)) {
114578f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "\n\n"));
114678f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n"));
114778f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
114878f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #                       WARNING!!!                       #\n"));
114978f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
115078f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #   This code was compiled with a debugging option.      #\n"));
115178f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #   To get timing results run ./configure                #\n"));
115278f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #   using --with-debugging=no, the performance will      #\n"));
115378f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #   be generally two or three times faster.              #\n"));
115478f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
115578f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n\n\n"));
115678f1b9b4SToby Isaac   }
115778f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
115878f1b9b4SToby Isaac }
115978f1b9b4SToby Isaac 
116078f1b9b4SToby Isaac static PetscErrorCode PetscLogViewWarnNoGpuAwareMpi(MPI_Comm comm, FILE *fd)
116178f1b9b4SToby Isaac {
116278f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
116378f1b9b4SToby Isaac   PetscMPIInt size;
116478f1b9b4SToby Isaac   PetscBool   deviceInitialized = PETSC_FALSE;
116578f1b9b4SToby Isaac 
116678f1b9b4SToby Isaac   PetscFunctionBegin;
116778f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_size(comm, &size));
116878f1b9b4SToby Isaac   for (int i = PETSC_DEVICE_HOST + 1; i < PETSC_DEVICE_MAX; ++i) {
116978f1b9b4SToby Isaac     const PetscDeviceType dtype = PetscDeviceTypeCast(i);
117078f1b9b4SToby Isaac     if (PetscDeviceInitialized(dtype)) { /* a non-host device was initialized */
117178f1b9b4SToby Isaac       deviceInitialized = PETSC_TRUE;
117278f1b9b4SToby Isaac       break;
117378f1b9b4SToby Isaac     }
117478f1b9b4SToby Isaac   }
117578f1b9b4SToby Isaac   /* the last condition says petsc is configured with device but it is a pure CPU run, so don't print misleading warnings */
117678f1b9b4SToby Isaac   if (use_gpu_aware_mpi || size == 1 || !deviceInitialized) PetscFunctionReturn(PETSC_SUCCESS);
117778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n\n"));
117878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n"));
117978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
118078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                       WARNING!!!                       #\n"));
118178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
118278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   This code was compiled with GPU support and you've   #\n"));
118378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   created PETSc/GPU objects, but you intentionally     #\n"));
118478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   used -use_gpu_aware_mpi 0, requiring PETSc to copy   #\n"));
118578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   additional data between the GPU and CPU. To obtain   #\n"));
118678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   meaningful timing results on multi-rank runs, use    #\n"));
118778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   GPU-aware MPI instead.                               #\n"));
118878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
118978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n\n\n"));
119078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
119178f1b9b4SToby Isaac #else
119278f1b9b4SToby Isaac   return PETSC_SUCCESS;
119378f1b9b4SToby Isaac #endif
119478f1b9b4SToby Isaac }
119578f1b9b4SToby Isaac 
119678f1b9b4SToby Isaac static PetscErrorCode PetscLogViewWarnGpuTime(MPI_Comm comm, FILE *fd)
119778f1b9b4SToby Isaac {
119878f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
119978f1b9b4SToby Isaac 
120078f1b9b4SToby Isaac   PetscFunctionBegin;
120178f1b9b4SToby Isaac   if (!PetscLogGpuTimeFlag || petsc_gflops == 0) PetscFunctionReturn(PETSC_SUCCESS);
120278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n\n"));
120378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n"));
120478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
120578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                       WARNING!!!                       #\n"));
120678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
120778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   This code was run with -log_view_gpu_time            #\n"));
120878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   This provides accurate timing within the GPU kernels #\n"));
120978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   but can slow down the entire computation by a        #\n"));
121078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   measurable amount. For fastest runs we recommend     #\n"));
121178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #   not using this option.                               #\n"));
121278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      #                                                        #\n"));
121378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      ##########################################################\n\n\n"));
121478f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
121578f1b9b4SToby Isaac #else
121678f1b9b4SToby Isaac   return PETSC_SUCCESS;
121778f1b9b4SToby Isaac #endif
121878f1b9b4SToby Isaac }
121978f1b9b4SToby Isaac 
122078f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerView_Default_Info(PetscLogHandler handler, PetscViewer viewer)
122178f1b9b4SToby Isaac {
122278f1b9b4SToby Isaac   FILE                   *fd;
122378f1b9b4SToby Isaac   PetscLogHandler_Default def = (PetscLogHandler_Default)handler->data;
122478f1b9b4SToby Isaac   char                    arch[128], hostname[128], username[128], pname[PETSC_MAX_PATH_LEN], date[128];
122578f1b9b4SToby Isaac   PetscLogDouble          locTotalTime, TotalTime, TotalFlops;
122678f1b9b4SToby Isaac   PetscLogDouble          numMessages, messageLength, avgMessLen, numReductions;
122778f1b9b4SToby Isaac   PetscLogDouble          stageTime, flops, flopr, mem, mess, messLen, red;
122878f1b9b4SToby Isaac   PetscLogDouble          fracTime, fracFlops, fracMessages, fracLength, fracReductions, fracMess, fracMessLen, fracRed;
122978f1b9b4SToby Isaac   PetscLogDouble          fracStageTime, fracStageFlops, fracStageMess, fracStageMessLen, fracStageRed;
123078f1b9b4SToby Isaac   PetscLogDouble          min, max, tot, ratio, avg, x, y;
123178f1b9b4SToby Isaac   PetscLogDouble          minf, maxf, totf, ratf, mint, maxt, tott, ratt, ratC, totm, totml, totr, mal, malmax, emalmax;
123278f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
123378f1b9b4SToby Isaac   PetscLogEvent  KSP_Solve, SNES_Solve, TS_Step, TAO_Solve; /* These need to be fixed to be some events registered with certain objects */
123478f1b9b4SToby Isaac   PetscLogDouble cct, gct, csz, gsz, gmaxt, gflops, gflopr, fracgflops;
123578f1b9b4SToby Isaac #endif
123678f1b9b4SToby Isaac   PetscMPIInt   minC, maxC;
123778f1b9b4SToby Isaac   PetscMPIInt   size, rank;
123878f1b9b4SToby Isaac   PetscBool    *localStageUsed, *stageUsed;
123978f1b9b4SToby Isaac   PetscBool    *localStageVisible, *stageVisible;
124078f1b9b4SToby Isaac   PetscInt      numStages, numEvents;
124178f1b9b4SToby Isaac   int           stage, oclass;
124278f1b9b4SToby Isaac   PetscLogEvent event;
124378f1b9b4SToby Isaac   char          version[256];
124478f1b9b4SToby Isaac   MPI_Comm      comm;
124578f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
124678f1b9b4SToby Isaac   PetscInt64 nas = 0x7FF0000000000002;
124778f1b9b4SToby Isaac #endif
124878f1b9b4SToby Isaac   PetscLogGlobalNames global_stages, global_events;
124978f1b9b4SToby Isaac   PetscEventPerfInfo  zero_info;
125078f1b9b4SToby Isaac   PetscLogState       state;
125178f1b9b4SToby Isaac 
125278f1b9b4SToby Isaac   PetscFunctionBegin;
125378f1b9b4SToby Isaac   PetscCall(PetscLogHandlerGetState(handler, &state));
125478f1b9b4SToby Isaac   PetscCall(PetscFPTrapPush(PETSC_FP_TRAP_OFF));
125578f1b9b4SToby Isaac   PetscCall(PetscObjectGetComm((PetscObject)viewer, &comm));
125678f1b9b4SToby Isaac   PetscCall(PetscViewerASCIIGetPointer(viewer, &fd));
125778f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_size(comm, &size));
125878f1b9b4SToby Isaac   PetscCallMPI(MPI_Comm_rank(comm, &rank));
125978f1b9b4SToby Isaac   /* Get the total elapsed time */
126078f1b9b4SToby Isaac   PetscCall(PetscTime(&locTotalTime));
126178f1b9b4SToby Isaac   locTotalTime -= petsc_BaseTime;
126278f1b9b4SToby Isaac 
126378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "****************************************************************************************************************************************************************\n"));
126478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "***                                WIDEN YOUR WINDOW TO 160 CHARACTERS.  Use 'enscript -r -fCourier9' to print this document                                 ***\n"));
126578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "****************************************************************************************************************************************************************\n"));
126678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n------------------------------------------------------------------ PETSc Performance Summary: ------------------------------------------------------------------\n\n"));
126778f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnSync(comm, fd));
126878f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnDebugging(comm, fd));
126978f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnNoGpuAwareMpi(comm, fd));
127078f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnGpuTime(comm, fd));
127178f1b9b4SToby Isaac   PetscCall(PetscGetArchType(arch, sizeof(arch)));
127278f1b9b4SToby Isaac   PetscCall(PetscGetHostName(hostname, sizeof(hostname)));
127378f1b9b4SToby Isaac   PetscCall(PetscGetUserName(username, sizeof(username)));
127478f1b9b4SToby Isaac   PetscCall(PetscGetProgramName(pname, sizeof(pname)));
127578f1b9b4SToby Isaac   PetscCall(PetscGetDate(date, sizeof(date)));
127678f1b9b4SToby Isaac   PetscCall(PetscGetVersion(version, sizeof(version)));
127778f1b9b4SToby Isaac   if (size == 1) {
127878f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "%s on a %s named %s with %d processor, by %s %s\n", pname, arch, hostname, size, username, date));
127978f1b9b4SToby Isaac   } else {
128078f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "%s on a %s named %s with %d processors, by %s %s\n", pname, arch, hostname, size, username, date));
128178f1b9b4SToby Isaac   }
128278f1b9b4SToby Isaac #if defined(PETSC_HAVE_OPENMP)
128378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Using %" PetscInt_FMT " OpenMP threads\n", PetscNumOMPThreads));
128478f1b9b4SToby Isaac #endif
128578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Using %s\n", version));
128678f1b9b4SToby Isaac 
128778f1b9b4SToby Isaac   /* Must preserve reduction count before we go on */
128878f1b9b4SToby Isaac   red = petsc_allreduce_ct + petsc_gather_ct + petsc_scatter_ct;
128978f1b9b4SToby Isaac 
129078f1b9b4SToby Isaac   /* Calculate summary information */
129178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n                         Max       Max/Min     Avg       Total\n"));
129278f1b9b4SToby Isaac   /*   Time */
129378f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&locTotalTime, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
129478f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&locTotalTime, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
129578f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&locTotalTime, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
129678f1b9b4SToby Isaac   avg = tot / ((PetscLogDouble)size);
129778f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
129878f1b9b4SToby Isaac   else ratio = 0.0;
129978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Time (sec):           %5.3e   %7.3f   %5.3e\n", max, ratio, avg));
130078f1b9b4SToby Isaac   TotalTime = tot;
130178f1b9b4SToby Isaac   /*   Objects */
130278f1b9b4SToby Isaac   {
130378f1b9b4SToby Isaac     PetscInt num_objects;
130478f1b9b4SToby Isaac 
130578f1b9b4SToby Isaac     PetscCall(PetscLogObjectArrayGetSize(def->petsc_objects, &num_objects, NULL));
130678f1b9b4SToby Isaac     avg = (PetscLogDouble)num_objects;
130778f1b9b4SToby Isaac   }
130878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&avg, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
130978f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&avg, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
131078f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&avg, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
131178f1b9b4SToby Isaac   avg = tot / ((PetscLogDouble)size);
131278f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
131378f1b9b4SToby Isaac   else ratio = 0.0;
131478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Objects:              %5.3e   %7.3f   %5.3e\n", max, ratio, avg));
131578f1b9b4SToby Isaac   /*   Flops */
131678f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&petsc_TotalFlops, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
131778f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&petsc_TotalFlops, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
131878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&petsc_TotalFlops, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
131978f1b9b4SToby Isaac   avg = tot / ((PetscLogDouble)size);
132078f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
132178f1b9b4SToby Isaac   else ratio = 0.0;
132278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Flops:                %5.3e   %7.3f   %5.3e  %5.3e\n", max, ratio, avg, tot));
132378f1b9b4SToby Isaac   TotalFlops = tot;
132478f1b9b4SToby Isaac   /*   Flops/sec -- Must talk to Barry here */
132578f1b9b4SToby Isaac   if (locTotalTime != 0.0) flops = petsc_TotalFlops / locTotalTime;
132678f1b9b4SToby Isaac   else flops = 0.0;
132778f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&flops, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
132878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&flops, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
132978f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&flops, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
133078f1b9b4SToby Isaac   avg = tot / ((PetscLogDouble)size);
133178f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
133278f1b9b4SToby Isaac   else ratio = 0.0;
133378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Flops/sec:            %5.3e   %7.3f   %5.3e  %5.3e\n", max, ratio, avg, tot));
133478f1b9b4SToby Isaac   /*   Memory */
133578f1b9b4SToby Isaac   PetscCall(PetscMallocGetMaximumUsage(&mem));
133678f1b9b4SToby Isaac   if (mem > 0.0) {
133778f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&mem, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
133878f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&mem, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
133978f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&mem, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
134078f1b9b4SToby Isaac     avg = tot / ((PetscLogDouble)size);
134178f1b9b4SToby Isaac     if (min != 0.0) ratio = max / min;
134278f1b9b4SToby Isaac     else ratio = 0.0;
134378f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Memory (bytes):       %5.3e   %7.3f   %5.3e  %5.3e\n", max, ratio, avg, tot));
134478f1b9b4SToby Isaac   }
134578f1b9b4SToby Isaac   /*   Messages */
134678f1b9b4SToby Isaac   mess = 0.5 * (petsc_irecv_ct + petsc_isend_ct + petsc_recv_ct + petsc_send_ct);
134778f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
134878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
134978f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
135078f1b9b4SToby Isaac   avg = tot / ((PetscLogDouble)size);
135178f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
135278f1b9b4SToby Isaac   else ratio = 0.0;
135378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "MPI Msg Count:        %5.3e   %7.3f   %5.3e  %5.3e\n", max, ratio, avg, tot));
135478f1b9b4SToby Isaac   numMessages = tot;
135578f1b9b4SToby Isaac   /*   Message Lengths */
135678f1b9b4SToby Isaac   mess = 0.5 * (petsc_irecv_len + petsc_isend_len + petsc_recv_len + petsc_send_len);
135778f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
135878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
135978f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&mess, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
136078f1b9b4SToby Isaac   if (numMessages != 0) avg = tot / numMessages;
136178f1b9b4SToby Isaac   else avg = 0.0;
136278f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
136378f1b9b4SToby Isaac   else ratio = 0.0;
136478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "MPI Msg Len (bytes):  %5.3e   %7.3f   %5.3e  %5.3e\n", max, ratio, avg, tot));
136578f1b9b4SToby Isaac   messageLength = tot;
136678f1b9b4SToby Isaac   /*   Reductions */
136778f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&red, &min, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
136878f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&red, &max, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
136978f1b9b4SToby Isaac   PetscCall(MPIU_Allreduce(&red, &tot, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
137078f1b9b4SToby Isaac   if (min != 0.0) ratio = max / min;
137178f1b9b4SToby Isaac   else ratio = 0.0;
137278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "MPI Reductions:       %5.3e   %7.3f\n", max, ratio));
137378f1b9b4SToby Isaac   numReductions = red; /* wrong because uses count from process zero */
137478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\nFlop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract)\n"));
137578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "                            e.g., VecAXPY() for real vectors of length N --> 2N flops\n"));
137678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "                            and VecAXPY() for complex vectors of length N --> 8N flops\n"));
137778f1b9b4SToby Isaac 
137878f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalStageNames(comm, state->registry, &global_stages));
137978f1b9b4SToby Isaac   PetscCall(PetscLogRegistryCreateGlobalEventNames(comm, state->registry, &global_events));
138078f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_stages, NULL, &numStages));
138178f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesGetSize(global_events, NULL, &numEvents));
138278f1b9b4SToby Isaac   PetscCall(PetscMemzero(&zero_info, sizeof(zero_info)));
138378f1b9b4SToby Isaac   PetscCall(PetscMalloc1(numStages, &localStageUsed));
138478f1b9b4SToby Isaac   PetscCall(PetscMalloc1(numStages, &stageUsed));
138578f1b9b4SToby Isaac   PetscCall(PetscMalloc1(numStages, &localStageVisible));
138678f1b9b4SToby Isaac   PetscCall(PetscMalloc1(numStages, &stageVisible));
138778f1b9b4SToby Isaac   if (numStages > 0) {
138878f1b9b4SToby Isaac     for (stage = 0; stage < numStages; stage++) {
138978f1b9b4SToby Isaac       PetscInt stage_id;
139078f1b9b4SToby Isaac 
139178f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
139278f1b9b4SToby Isaac       if (stage_id >= 0) {
139378f1b9b4SToby Isaac         PetscStagePerf *stage_info;
139478f1b9b4SToby Isaac 
139578f1b9b4SToby Isaac         PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage, &stage_info));
139678f1b9b4SToby Isaac         localStageUsed[stage]    = stage_info->used;
139778f1b9b4SToby Isaac         localStageVisible[stage] = stage_info->perfInfo.visible;
139878f1b9b4SToby Isaac       } else {
139978f1b9b4SToby Isaac         localStageUsed[stage]    = PETSC_FALSE;
140078f1b9b4SToby Isaac         localStageVisible[stage] = PETSC_TRUE;
140178f1b9b4SToby Isaac       }
140278f1b9b4SToby Isaac     }
140378f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(localStageUsed, stageUsed, numStages, MPIU_BOOL, MPI_LOR, comm));
140478f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(localStageVisible, stageVisible, numStages, MPIU_BOOL, MPI_LAND, comm));
140578f1b9b4SToby Isaac     for (stage = 0; stage < numStages; stage++) {
140678f1b9b4SToby Isaac       if (stageUsed[stage] && stageVisible[stage]) {
140778f1b9b4SToby Isaac         PetscCall(PetscFPrintf(comm, fd, "\nSummary of Stages:   ----- Time ------  ----- Flop ------  --- Messages ---  -- Message Lengths --  -- Reductions --\n"));
140878f1b9b4SToby Isaac         PetscCall(PetscFPrintf(comm, fd, "                        Avg     %%Total     Avg     %%Total    Count   %%Total     Avg         %%Total    Count   %%Total\n"));
140978f1b9b4SToby Isaac         break;
141078f1b9b4SToby Isaac       }
141178f1b9b4SToby Isaac     }
141278f1b9b4SToby Isaac     for (stage = 0; stage < numStages; stage++) {
141378f1b9b4SToby Isaac       PetscInt            stage_id;
141478f1b9b4SToby Isaac       PetscEventPerfInfo *stage_info;
141578f1b9b4SToby Isaac       const char         *stage_name;
141678f1b9b4SToby Isaac 
141778f1b9b4SToby Isaac       if (!(stageUsed[stage] && stageVisible[stage])) continue;
141878f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
141978f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
142078f1b9b4SToby Isaac       stage_info = &zero_info;
142178f1b9b4SToby Isaac       if (localStageUsed[stage]) {
142278f1b9b4SToby Isaac         PetscStagePerf *stage_perf_info;
142378f1b9b4SToby Isaac 
142478f1b9b4SToby Isaac         PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage, &stage_perf_info));
142578f1b9b4SToby Isaac         stage_info = &stage_perf_info->perfInfo;
142678f1b9b4SToby Isaac       }
142778f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(&stage_info->time, &stageTime, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
142878f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(&stage_info->flops, &flops, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
142978f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(&stage_info->numMessages, &mess, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
143078f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(&stage_info->messageLength, &messLen, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
143178f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(&stage_info->numReductions, &red, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
143278f1b9b4SToby Isaac       mess *= 0.5;
143378f1b9b4SToby Isaac       messLen *= 0.5;
143478f1b9b4SToby Isaac       red /= size;
143578f1b9b4SToby Isaac       if (TotalTime != 0.0) fracTime = stageTime / TotalTime;
143678f1b9b4SToby Isaac       else fracTime = 0.0;
143778f1b9b4SToby Isaac       if (TotalFlops != 0.0) fracFlops = flops / TotalFlops;
143878f1b9b4SToby Isaac       else fracFlops = 0.0;
143978f1b9b4SToby Isaac       /* Talk to Barry if (stageTime     != 0.0) flops          = (size*flops)/stageTime; else flops          = 0.0; */
144078f1b9b4SToby Isaac       if (numMessages != 0.0) fracMessages = mess / numMessages;
144178f1b9b4SToby Isaac       else fracMessages = 0.0;
144278f1b9b4SToby Isaac       if (mess != 0.0) avgMessLen = messLen / mess;
144378f1b9b4SToby Isaac       else avgMessLen = 0.0;
144478f1b9b4SToby Isaac       if (messageLength != 0.0) fracLength = messLen / messageLength;
144578f1b9b4SToby Isaac       else fracLength = 0.0;
144678f1b9b4SToby Isaac       if (numReductions != 0.0) fracReductions = red / numReductions;
144778f1b9b4SToby Isaac       else fracReductions = 0.0;
144878f1b9b4SToby Isaac       PetscCall(PetscFPrintf(comm, fd, "%2d: %15s: %6.4e %5.1f%%  %6.4e %5.1f%%  %5.3e %5.1f%%  %5.3e      %5.1f%%  %5.3e %5.1f%%\n", stage, stage_name, stageTime / size, 100.0 * fracTime, flops, 100.0 * fracFlops, mess, 100.0 * fracMessages, avgMessLen, 100.0 * fracLength, red, 100.0 * fracReductions));
144978f1b9b4SToby Isaac     }
145078f1b9b4SToby Isaac   }
145178f1b9b4SToby Isaac 
145278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n------------------------------------------------------------------------------------------------------------------------\n"));
145378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "See the 'Profiling' chapter of the users' manual for details on interpreting output.\n"));
145478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Phase summary info:\n"));
145578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Count: number of times phase was executed\n"));
145678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Time and Flop: Max - maximum over all processors\n"));
145778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "                  Ratio - ratio of maximum to minimum over all processors\n"));
145878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Mess: number of messages sent\n"));
145978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   AvgLen: average message length (bytes)\n"));
146078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Reduct: number of global reductions\n"));
146178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Global: entire computation\n"));
146278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Stage: stages of a computation. Set stages with PetscLogStagePush() and PetscLogStagePop().\n"));
146378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      %%T - percent time in this phase         %%F - percent flop in this phase\n"));
146478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      %%M - percent messages in this phase     %%L - percent message lengths in this phase\n"));
146578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "      %%R - percent reductions in this phase\n"));
146678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   Total Mflop/s: 10e-6 * (sum of flop over all processors)/(max time over all processors)\n"));
146778f1b9b4SToby Isaac   if (PetscLogMemory) {
146878f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "   Memory usage is summed over all MPI processes, it is given in mega-bytes\n"));
146978f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "   Malloc Mbytes: Memory allocated and kept during event (sum over all calls to event). May be negative\n"));
147078f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "   EMalloc Mbytes: extra memory allocated during event and then freed (maximum over all calls to events). Never negative\n"));
147178f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "   MMalloc Mbytes: Increase in high water mark of allocated memory (sum over all calls to event). Never negative\n"));
147278f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "   RMI Mbytes: Increase in resident memory (sum over all calls to event)\n"));
147378f1b9b4SToby Isaac   }
147478f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
147578f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   GPU Mflop/s: 10e-6 * (sum of flop on GPU over all processors)/(max GPU time over all processors)\n"));
147678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   CpuToGpu Count: total number of CPU to GPU copies per processor\n"));
147778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   CpuToGpu Size (Mbytes): 10e-6 * (total size of CPU to GPU copies per processor)\n"));
147878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   GpuToCpu Count: total number of GPU to CPU copies per processor\n"));
147978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   GpuToCpu Size (Mbytes): 10e-6 * (total size of GPU to CPU copies per processor)\n"));
148078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   GPU %%F: percent flops on GPU in this event\n"));
148178f1b9b4SToby Isaac #endif
148278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "------------------------------------------------------------------------------------------------------------------------\n"));
148378f1b9b4SToby Isaac 
148478f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnDebugging(comm, fd));
148578f1b9b4SToby Isaac 
148678f1b9b4SToby Isaac   /* Report events */
148778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Event                Count      Time (sec)     Flop                              --- Global ---  --- Stage ----  Total"));
148878f1b9b4SToby Isaac   if (PetscLogMemory) PetscCall(PetscFPrintf(comm, fd, "  Malloc EMalloc MMalloc RMI"));
148978f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
149078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "   GPU    - CpuToGpu -   - GpuToCpu - GPU"));
149178f1b9b4SToby Isaac #endif
149278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
149378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "                   Max Ratio  Max     Ratio   Max  Ratio  Mess   AvgLen  Reduct  %%T %%F %%M %%L %%R  %%T %%F %%M %%L %%R Mflop/s"));
149478f1b9b4SToby Isaac   if (PetscLogMemory) PetscCall(PetscFPrintf(comm, fd, " Mbytes Mbytes Mbytes Mbytes"));
149578f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
149678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, " Mflop/s Count   Size   Count   Size  %%F"));
149778f1b9b4SToby Isaac #endif
149878f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
149978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "------------------------------------------------------------------------------------------------------------------------"));
150078f1b9b4SToby Isaac   if (PetscLogMemory) PetscCall(PetscFPrintf(comm, fd, "-----------------------------"));
150178f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
150278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "---------------------------------------"));
150378f1b9b4SToby Isaac #endif
150478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
150578f1b9b4SToby Isaac 
150678f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
150778f1b9b4SToby Isaac   /* this indirect way of accessing these values is needed when PETSc is build with multiple libraries since the symbols are not in libpetscsys */
150878f1b9b4SToby Isaac   PetscCall(PetscLogStateGetEventFromName(state, "TAOSolve", &TAO_Solve));
150978f1b9b4SToby Isaac   PetscCall(PetscLogStateGetEventFromName(state, "TSStep", &TS_Step));
151078f1b9b4SToby Isaac   PetscCall(PetscLogStateGetEventFromName(state, "SNESSolve", &SNES_Solve));
151178f1b9b4SToby Isaac   PetscCall(PetscLogStateGetEventFromName(state, "KSPSolve", &KSP_Solve));
151278f1b9b4SToby Isaac #endif
151378f1b9b4SToby Isaac 
151478f1b9b4SToby Isaac   for (stage = 0; stage < numStages; stage++) {
151578f1b9b4SToby Isaac     PetscInt            stage_id;
151678f1b9b4SToby Isaac     PetscEventPerfInfo *stage_info;
151778f1b9b4SToby Isaac     const char         *stage_name;
151878f1b9b4SToby Isaac 
151978f1b9b4SToby Isaac     if (!(stageVisible[stage] && stageUsed[stage])) continue;
152078f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_stages, stage, &stage_id));
152178f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
152278f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "\n--- Event Stage %d: %s\n\n", stage, stage_name));
152378f1b9b4SToby Isaac     stage_info = &zero_info;
152478f1b9b4SToby Isaac     if (localStageUsed[stage]) {
152578f1b9b4SToby Isaac       PetscStagePerf *stage_perf_info;
152678f1b9b4SToby Isaac 
152778f1b9b4SToby Isaac       PetscCall(PetscLogHandlerDefaultGetStageInfo(handler, stage_id, &stage_perf_info));
152878f1b9b4SToby Isaac       stage_info = &stage_perf_info->perfInfo;
152978f1b9b4SToby Isaac     }
153078f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&stage_info->time, &stageTime, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
153178f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&stage_info->flops, &flops, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
153278f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&stage_info->numMessages, &mess, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
153378f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&stage_info->messageLength, &messLen, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
153478f1b9b4SToby Isaac     PetscCall(MPIU_Allreduce(&stage_info->numReductions, &red, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
153578f1b9b4SToby Isaac     mess *= 0.5;
153678f1b9b4SToby Isaac     messLen *= 0.5;
153778f1b9b4SToby Isaac     red /= size;
153878f1b9b4SToby Isaac 
153978f1b9b4SToby Isaac     for (event = 0; event < numEvents; event++) {
154078f1b9b4SToby Isaac       PetscInt            event_id;
154178f1b9b4SToby Isaac       PetscEventPerfInfo *event_info = &zero_info;
154278f1b9b4SToby Isaac       PetscBool           is_zero    = PETSC_FALSE;
154378f1b9b4SToby Isaac       const char         *event_name;
154478f1b9b4SToby Isaac 
154578f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetLocal(global_events, event, &event_id));
154678f1b9b4SToby Isaac       PetscCall(PetscLogGlobalNamesGlobalGetName(global_events, event, &event_name));
1547*dff009beSToby Isaac       if (event_id >= 0 && stage_id >= 0) { PetscCall(PetscLogHandlerGetEventPerfInfo_Default(handler, stage_id, event_id, &event_info)); }
154878f1b9b4SToby Isaac       PetscCall(PetscMemcmp(event_info, &zero_info, sizeof(zero_info), &is_zero));
154978f1b9b4SToby Isaac       PetscCall(MPIU_Allreduce(MPI_IN_PLACE, &is_zero, 1, MPIU_BOOL, MPI_LAND, comm));
155078f1b9b4SToby Isaac       if (!is_zero) {
155178f1b9b4SToby Isaac         flopr = event_info->flops;
155278f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&flopr, &minf, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
155378f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&flopr, &maxf, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
155478f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->flops, &totf, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
155578f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->time, &mint, 1, MPIU_PETSCLOGDOUBLE, MPI_MIN, comm));
155678f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->time, &maxt, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
155778f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->time, &tott, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
155878f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->numMessages, &totm, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
155978f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->messageLength, &totml, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156078f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->numReductions, &totr, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156178f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->count, &minC, 1, MPI_INT, MPI_MIN, comm));
156278f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->count, &maxC, 1, MPI_INT, MPI_MAX, comm));
156378f1b9b4SToby Isaac         if (PetscLogMemory) {
156478f1b9b4SToby Isaac           PetscCall(MPIU_Allreduce(&event_info->memIncrease, &mem, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156578f1b9b4SToby Isaac           PetscCall(MPIU_Allreduce(&event_info->mallocSpace, &mal, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156678f1b9b4SToby Isaac           PetscCall(MPIU_Allreduce(&event_info->mallocIncrease, &malmax, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156778f1b9b4SToby Isaac           PetscCall(MPIU_Allreduce(&event_info->mallocIncreaseEvent, &emalmax, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
156878f1b9b4SToby Isaac         }
156978f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
157078f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->CpuToGpuCount, &cct, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
157178f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->GpuToCpuCount, &gct, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
157278f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->CpuToGpuSize, &csz, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
157378f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->GpuToCpuSize, &gsz, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
157478f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->GpuFlops, &gflops, 1, MPIU_PETSCLOGDOUBLE, MPI_SUM, comm));
157578f1b9b4SToby Isaac         PetscCall(MPIU_Allreduce(&event_info->GpuTime, &gmaxt, 1, MPIU_PETSCLOGDOUBLE, MPI_MAX, comm));
157678f1b9b4SToby Isaac #endif
157778f1b9b4SToby Isaac         if (mint < 0.0) {
157878f1b9b4SToby Isaac           PetscCall(PetscFPrintf(comm, fd, "WARNING!!! Minimum time %g over all processors for %s is negative! This happens\n on some machines whose times cannot handle too rapid calls.!\n artificially changing minimum to zero.\n", mint, event_name));
157978f1b9b4SToby Isaac           mint = 0;
158078f1b9b4SToby Isaac         }
158178f1b9b4SToby Isaac         PetscCheck(minf >= 0.0, PETSC_COMM_SELF, PETSC_ERR_PLIB, "Minimum flop %g over all processors for %s is negative! Not possible!", minf, event_name);
158278f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
158378f1b9b4SToby Isaac         /* Put NaN into the time for all events that may not be time accurately since they may happen asynchronously on the GPU */
158478f1b9b4SToby Isaac         if (!PetscLogGpuTimeFlag && petsc_gflops > 0) {
158578f1b9b4SToby Isaac           memcpy(&gmaxt, &nas, sizeof(PetscLogDouble));
158678f1b9b4SToby Isaac           if (event_id != SNES_Solve && event_id != KSP_Solve && event_id != TS_Step && event_id != TAO_Solve) {
158778f1b9b4SToby Isaac             memcpy(&mint, &nas, sizeof(PetscLogDouble));
158878f1b9b4SToby Isaac             memcpy(&maxt, &nas, sizeof(PetscLogDouble));
158978f1b9b4SToby Isaac           }
159078f1b9b4SToby Isaac         }
159178f1b9b4SToby Isaac #endif
159278f1b9b4SToby Isaac         totm *= 0.5;
159378f1b9b4SToby Isaac         totml *= 0.5;
159478f1b9b4SToby Isaac         totr /= size;
159578f1b9b4SToby Isaac 
159678f1b9b4SToby Isaac         if (maxC != 0) {
159778f1b9b4SToby Isaac           if (minC != 0) ratC = ((PetscLogDouble)maxC) / minC;
159878f1b9b4SToby Isaac           else ratC = 0.0;
159978f1b9b4SToby Isaac           if (mint != 0.0) ratt = maxt / mint;
160078f1b9b4SToby Isaac           else ratt = 0.0;
160178f1b9b4SToby Isaac           if (minf != 0.0) ratf = maxf / minf;
160278f1b9b4SToby Isaac           else ratf = 0.0;
160378f1b9b4SToby Isaac           if (TotalTime != 0.0) fracTime = tott / TotalTime;
160478f1b9b4SToby Isaac           else fracTime = 0.0;
160578f1b9b4SToby Isaac           if (TotalFlops != 0.0) fracFlops = totf / TotalFlops;
160678f1b9b4SToby Isaac           else fracFlops = 0.0;
160778f1b9b4SToby Isaac           if (stageTime != 0.0) fracStageTime = tott / stageTime;
160878f1b9b4SToby Isaac           else fracStageTime = 0.0;
160978f1b9b4SToby Isaac           if (flops != 0.0) fracStageFlops = totf / flops;
161078f1b9b4SToby Isaac           else fracStageFlops = 0.0;
161178f1b9b4SToby Isaac           if (numMessages != 0.0) fracMess = totm / numMessages;
161278f1b9b4SToby Isaac           else fracMess = 0.0;
161378f1b9b4SToby Isaac           if (messageLength != 0.0) fracMessLen = totml / messageLength;
161478f1b9b4SToby Isaac           else fracMessLen = 0.0;
161578f1b9b4SToby Isaac           if (numReductions != 0.0) fracRed = totr / numReductions;
161678f1b9b4SToby Isaac           else fracRed = 0.0;
161778f1b9b4SToby Isaac           if (mess != 0.0) fracStageMess = totm / mess;
161878f1b9b4SToby Isaac           else fracStageMess = 0.0;
161978f1b9b4SToby Isaac           if (messLen != 0.0) fracStageMessLen = totml / messLen;
162078f1b9b4SToby Isaac           else fracStageMessLen = 0.0;
162178f1b9b4SToby Isaac           if (red != 0.0) fracStageRed = totr / red;
162278f1b9b4SToby Isaac           else fracStageRed = 0.0;
162378f1b9b4SToby Isaac           if (totm != 0.0) totml /= totm;
162478f1b9b4SToby Isaac           else totml = 0.0;
162578f1b9b4SToby Isaac           if (maxt != 0.0) flopr = totf / maxt;
162678f1b9b4SToby Isaac           else flopr = 0.0;
162778f1b9b4SToby Isaac           if (fracStageTime > 1.0 || fracStageFlops > 1.0 || fracStageMess > 1.0 || fracStageMessLen > 1.0 || fracStageRed > 1.0)
162878f1b9b4SToby Isaac             PetscCall(PetscFPrintf(comm, fd, "%-16s %7d %3.1f %5.4e %3.1f %3.2e %3.1f %2.1e %2.1e %2.1e %2.0f %2.0f %2.0f %2.0f %2.0f Multiple stages %5.0f", event_name, maxC, ratC, maxt, ratt, maxf, ratf, totm, totml, totr, 100.0 * fracTime, 100.0 * fracFlops, 100.0 * fracMess, 100.0 * fracMessLen, 100.0 * fracRed, PetscAbs(flopr) / 1.0e6));
162978f1b9b4SToby Isaac           else
163078f1b9b4SToby Isaac             PetscCall(PetscFPrintf(comm, fd, "%-16s %7d %3.1f %5.4e %3.1f %3.2e %3.1f %2.1e %2.1e %2.1e %2.0f %2.0f %2.0f %2.0f %2.0f %3.0f %2.0f %2.0f %2.0f %2.0f %5.0f", event_name, maxC, ratC, maxt, ratt, maxf, ratf, totm, totml, totr, 100.0 * fracTime, 100.0 * fracFlops, 100.0 * fracMess, 100.0 * fracMessLen, 100.0 * fracRed, 100.0 * fracStageTime, 100.0 * fracStageFlops, 100.0 * fracStageMess, 100.0 * fracStageMessLen, 100.0 * fracStageRed, PetscAbs(flopr) / 1.0e6));
163178f1b9b4SToby Isaac           if (PetscLogMemory) PetscCall(PetscFPrintf(comm, fd, " %5.0f   %5.0f   %5.0f   %5.0f", mal / 1.0e6, emalmax / 1.0e6, malmax / 1.0e6, mem / 1.0e6));
163278f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
163378f1b9b4SToby Isaac           if (totf != 0.0) fracgflops = gflops / totf;
163478f1b9b4SToby Isaac           else fracgflops = 0.0;
163578f1b9b4SToby Isaac           if (gmaxt != 0.0) gflopr = gflops / gmaxt;
163678f1b9b4SToby Isaac           else gflopr = 0.0;
163778f1b9b4SToby Isaac           PetscCall(PetscFPrintf(comm, fd, "   %5.0f   %4.0f %3.2e %4.0f %3.2e % 2.0f", PetscAbs(gflopr) / 1.0e6, cct / size, csz / (1.0e6 * size), gct / size, gsz / (1.0e6 * size), 100.0 * fracgflops));
163878f1b9b4SToby Isaac #endif
163978f1b9b4SToby Isaac           PetscCall(PetscFPrintf(comm, fd, "\n"));
164078f1b9b4SToby Isaac         }
164178f1b9b4SToby Isaac       }
164278f1b9b4SToby Isaac     }
164378f1b9b4SToby Isaac   }
164478f1b9b4SToby Isaac 
164578f1b9b4SToby Isaac   /* Memory usage and object creation */
164678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "------------------------------------------------------------------------------------------------------------------------"));
164778f1b9b4SToby Isaac   if (PetscLogMemory) PetscCall(PetscFPrintf(comm, fd, "-----------------------------"));
164878f1b9b4SToby Isaac #if defined(PETSC_HAVE_DEVICE)
164978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "---------------------------------------"));
165078f1b9b4SToby Isaac #endif
165178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
165278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
165378f1b9b4SToby Isaac 
165478f1b9b4SToby Isaac   /* Right now, only stages on the first processor are reported here, meaning only objects associated with
165578f1b9b4SToby Isaac      the global communicator, or MPI_COMM_SELF for proc 1. We really should report global stats and then
165678f1b9b4SToby Isaac      stats for stages local to processor sets.
165778f1b9b4SToby Isaac   */
165878f1b9b4SToby Isaac   /* We should figure out the longest object name here (now 20 characters) */
165978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Object Type          Creations   Destructions. Reports information only for process 0.\n"));
166078f1b9b4SToby Isaac   for (stage = 0; stage < numStages; stage++) {
166178f1b9b4SToby Isaac     const char *stage_name;
166278f1b9b4SToby Isaac 
166378f1b9b4SToby Isaac     PetscCall(PetscLogGlobalNamesGlobalGetName(global_stages, stage, &stage_name));
166478f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "\n--- Event Stage %d: %s\n\n", stage, stage_name));
166578f1b9b4SToby Isaac     if (localStageUsed[stage]) {
166678f1b9b4SToby Isaac       PetscInt num_classes;
166778f1b9b4SToby Isaac 
166878f1b9b4SToby Isaac       PetscCall(PetscLogStateGetNumClasses(state, &num_classes));
166978f1b9b4SToby Isaac       for (oclass = 0; oclass < num_classes; oclass++) {
167078f1b9b4SToby Isaac         PetscClassPerf *class_perf_info;
167178f1b9b4SToby Isaac 
167278f1b9b4SToby Isaac         PetscCall(PetscLogHandlerDefaultGetClassPerf(handler, stage, oclass, &class_perf_info));
167378f1b9b4SToby Isaac         if ((class_perf_info->creations > 0) || (class_perf_info->destructions > 0)) {
167478f1b9b4SToby Isaac           PetscLogClassInfo class_reg_info;
167578f1b9b4SToby Isaac 
167678f1b9b4SToby Isaac           PetscCall(PetscLogStateClassGetInfo(state, oclass, &class_reg_info));
167778f1b9b4SToby Isaac           PetscCall(PetscFPrintf(comm, fd, "%20s %5d          %5d\n", class_reg_info.name, class_perf_info->creations, class_perf_info->destructions));
167878f1b9b4SToby Isaac         }
167978f1b9b4SToby Isaac       }
168078f1b9b4SToby Isaac     }
168178f1b9b4SToby Isaac   }
168278f1b9b4SToby Isaac 
168378f1b9b4SToby Isaac   PetscCall(PetscFree(localStageUsed));
168478f1b9b4SToby Isaac   PetscCall(PetscFree(stageUsed));
168578f1b9b4SToby Isaac   PetscCall(PetscFree(localStageVisible));
168678f1b9b4SToby Isaac   PetscCall(PetscFree(stageVisible));
168778f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_stages));
168878f1b9b4SToby Isaac   PetscCall(PetscLogGlobalNamesDestroy(&global_events));
168978f1b9b4SToby Isaac 
169078f1b9b4SToby Isaac   /* Information unrelated to this particular run */
169178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "========================================================================================================================\n"));
169278f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169378f1b9b4SToby Isaac   PetscCall(PetscTime(&x));
169478f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169578f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169678f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169778f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169878f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
169978f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
170078f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
170178f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
170278f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
170378f1b9b4SToby Isaac   PetscCall(PetscTime(&y));
170478f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Average time to get PetscTime(): %g\n", (y - x) / 10.0));
170578f1b9b4SToby Isaac   /* MPI information */
170678f1b9b4SToby Isaac   if (size > 1) {
170778f1b9b4SToby Isaac     MPI_Status  status;
170878f1b9b4SToby Isaac     PetscMPIInt tag;
170978f1b9b4SToby Isaac     MPI_Comm    newcomm;
171078f1b9b4SToby Isaac 
171178f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171278f1b9b4SToby Isaac     PetscCall(PetscTime(&x));
171378f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171478f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171578f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171678f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171778f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
171878f1b9b4SToby Isaac     PetscCall(PetscTime(&y));
171978f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Average time for MPI_Barrier(): %g\n", (y - x) / 5.0));
172078f1b9b4SToby Isaac     PetscCall(PetscCommDuplicate(comm, &newcomm, &tag));
172178f1b9b4SToby Isaac     PetscCallMPI(MPI_Barrier(comm));
172278f1b9b4SToby Isaac     if (rank) {
172378f1b9b4SToby Isaac       PetscCallMPI(MPI_Recv(NULL, 0, MPI_INT, rank - 1, tag, newcomm, &status));
172478f1b9b4SToby Isaac       PetscCallMPI(MPI_Send(NULL, 0, MPI_INT, (rank + 1) % size, tag, newcomm));
172578f1b9b4SToby Isaac     } else {
172678f1b9b4SToby Isaac       PetscCall(PetscTime(&x));
172778f1b9b4SToby Isaac       PetscCallMPI(MPI_Send(NULL, 0, MPI_INT, 1, tag, newcomm));
172878f1b9b4SToby Isaac       PetscCallMPI(MPI_Recv(NULL, 0, MPI_INT, size - 1, tag, newcomm, &status));
172978f1b9b4SToby Isaac       PetscCall(PetscTime(&y));
173078f1b9b4SToby Isaac       PetscCall(PetscFPrintf(comm, fd, "Average time for zero size MPI_Send(): %g\n", (y - x) / size));
173178f1b9b4SToby Isaac     }
173278f1b9b4SToby Isaac     PetscCall(PetscCommDestroy(&newcomm));
173378f1b9b4SToby Isaac   }
173478f1b9b4SToby Isaac   PetscCall(PetscOptionsView(NULL, viewer));
173578f1b9b4SToby Isaac 
173678f1b9b4SToby Isaac   /* Machine and compile information */
173778f1b9b4SToby Isaac   if (PetscDefined(USE_FORTRAN_KERNELS)) {
173878f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with FORTRAN kernels\n"));
173978f1b9b4SToby Isaac   } else {
174078f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled without FORTRAN kernels\n"));
174178f1b9b4SToby Isaac   }
174278f1b9b4SToby Isaac   if (PetscDefined(USE_64BIT_INDICES)) {
174378f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with 64-bit PetscInt\n"));
174478f1b9b4SToby Isaac   } else if (PetscDefined(USE___FLOAT128)) {
174578f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with 32-bit PetscInt\n"));
174678f1b9b4SToby Isaac   }
174778f1b9b4SToby Isaac   if (PetscDefined(USE_REAL_SINGLE)) {
174878f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with single precision PetscScalar and PetscReal\n"));
174978f1b9b4SToby Isaac   } else if (PetscDefined(USE___FLOAT128)) {
175078f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with 128 bit precision PetscScalar and PetscReal\n"));
175178f1b9b4SToby Isaac   }
175278f1b9b4SToby Isaac   if (PetscDefined(USE_REAL_MAT_SINGLE)) {
175378f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with single precision matrices\n"));
175478f1b9b4SToby Isaac   } else {
175578f1b9b4SToby Isaac     PetscCall(PetscFPrintf(comm, fd, "Compiled with full precision matrices (default)\n"));
175678f1b9b4SToby Isaac   }
175778f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "sizeof(short) %d sizeof(int) %d sizeof(long) %d sizeof(void*) %d sizeof(PetscScalar) %d sizeof(PetscInt) %d\n", (int)sizeof(short), (int)sizeof(int), (int)sizeof(long), (int)sizeof(void *), (int)sizeof(PetscScalar), (int)sizeof(PetscInt)));
175878f1b9b4SToby Isaac 
175978f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "Configure options: %s", petscconfigureoptions));
176078f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "%s", petscmachineinfo));
176178f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "%s", petsccompilerinfo));
176278f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "%s", petsccompilerflagsinfo));
176378f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "%s", petsclinkerinfo));
176478f1b9b4SToby Isaac 
176578f1b9b4SToby Isaac   /* Cleanup */
176678f1b9b4SToby Isaac   PetscCall(PetscFPrintf(comm, fd, "\n"));
176778f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnNoGpuAwareMpi(comm, fd));
176878f1b9b4SToby Isaac   PetscCall(PetscLogViewWarnDebugging(comm, fd));
176978f1b9b4SToby Isaac   PetscCall(PetscFPTrapPop());
177078f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
177178f1b9b4SToby Isaac }
177278f1b9b4SToby Isaac 
177378f1b9b4SToby Isaac static PetscErrorCode PetscLogHandlerView_Default(PetscLogHandler handler, PetscViewer viewer)
177478f1b9b4SToby Isaac {
177578f1b9b4SToby Isaac   PetscViewerFormat format;
177678f1b9b4SToby Isaac   PetscFunctionBegin;
177778f1b9b4SToby Isaac   PetscCall(PetscViewerGetFormat(viewer, &format));
177878f1b9b4SToby Isaac   if (format == PETSC_VIEWER_DEFAULT || format == PETSC_VIEWER_ASCII_INFO) {
177978f1b9b4SToby Isaac     PetscCall(PetscLogHandlerView_Default_Info(handler, viewer));
178078f1b9b4SToby Isaac   } else if (format == PETSC_VIEWER_ASCII_INFO_DETAIL) {
178178f1b9b4SToby Isaac     PetscCall(PetscLogHandlerView_Default_Detailed(handler, viewer));
178278f1b9b4SToby Isaac   } else if (format == PETSC_VIEWER_ASCII_CSV) {
178378f1b9b4SToby Isaac     PetscCall(PetscLogHandlerView_Default_CSV(handler, viewer));
178478f1b9b4SToby Isaac   }
178578f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
178678f1b9b4SToby Isaac }
178778f1b9b4SToby Isaac 
178878f1b9b4SToby Isaac /*MC
1789294de794SToby Isaac   PETSCLOGHANDLERDEFAULT - PETSCLOGHANDLERDEFAULT = "default" -  A `PetscLogHandler` that collects data for PETSc
1790b665b14eSToby Isaac   default profiling log viewers (`PetscLogView()` and `PetscLogDump()`).  A log handler of this type is
1791b665b14eSToby Isaac   created and started (`PetscLogHandlerStart()`) by `PetscLogDefaultBegin()`.
179278f1b9b4SToby Isaac 
179378f1b9b4SToby Isaac   Options Database Keys:
179478f1b9b4SToby Isaac + -log_include_actions - include a growing list of actions (event beginnings and endings, object creations and destructions) in `PetscLogDump()` (`PetscLogActions()`).
179578f1b9b4SToby Isaac - -log_include_objects - include a growing list of object creations and destructions in `PetscLogDump()` (`PetscLogObjects()`).
179678f1b9b4SToby Isaac 
179778f1b9b4SToby Isaac   Level: developer
179878f1b9b4SToby Isaac 
179978f1b9b4SToby Isaac .seealso: [](ch_profiling), `PetscLogHandler`
180078f1b9b4SToby Isaac M*/
180178f1b9b4SToby Isaac 
180278f1b9b4SToby Isaac PETSC_INTERN PetscErrorCode PetscLogHandlerCreate_Default(PetscLogHandler handler)
180378f1b9b4SToby Isaac {
180478f1b9b4SToby Isaac   PetscFunctionBegin;
180578f1b9b4SToby Isaac   PetscCall(PetscLogHandlerContextCreate_Default((PetscLogHandler_Default *)&handler->data));
180678f1b9b4SToby Isaac   handler->ops->destroy       = PetscLogHandlerDestroy_Default;
180778f1b9b4SToby Isaac   handler->ops->eventbegin    = PetscLogHandlerEventBegin_Default;
180878f1b9b4SToby Isaac   handler->ops->eventend      = PetscLogHandlerEventEnd_Default;
180978f1b9b4SToby Isaac   handler->ops->eventsync     = PetscLogHandlerEventSync_Default;
181078f1b9b4SToby Isaac   handler->ops->objectcreate  = PetscLogHandlerObjectCreate_Default;
181178f1b9b4SToby Isaac   handler->ops->objectdestroy = PetscLogHandlerObjectDestroy_Default;
181278f1b9b4SToby Isaac   handler->ops->stagepush     = PetscLogHandlerStagePush_Default;
181378f1b9b4SToby Isaac   handler->ops->stagepop      = PetscLogHandlerStagePop_Default;
181478f1b9b4SToby Isaac   handler->ops->view          = PetscLogHandlerView_Default;
1815*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerGetEventPerfInfo_C", PetscLogHandlerGetEventPerfInfo_Default));
1816*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerSetLogActions_C", PetscLogHandlerSetLogActions_Default));
1817*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerSetLogObjects_C", PetscLogHandlerSetLogObjects_Default));
1818*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerLogObjectState_C", PetscLogHandlerLogObjectState_Default));
1819*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerGetNumObjects_C", PetscLogHandlerGetNumObjects_Default));
1820*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerEventDeactivatePush_C", PetscLogHandlerEventDeactivatePush_Default));
1821*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerEventDeactivatePop_C", PetscLogHandlerEventDeactivatePop_Default));
1822*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerEventsPause_C", PetscLogHandlerEventsPause_Default));
1823*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerEventsResume_C", PetscLogHandlerEventsResume_Default));
1824*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerDump_C", PetscLogHandlerDump_Default));
1825*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerStageSetVisible_C", PetscLogHandlerStageSetVisible_Default));
1826*dff009beSToby Isaac   PetscCall(PetscObjectComposeFunction((PetscObject)handler, "PetscLogHandlerStageGetVisible_C", PetscLogHandlerStageGetVisible_Default));
182778f1b9b4SToby Isaac   PetscFunctionReturn(PETSC_SUCCESS);
182878f1b9b4SToby Isaac }
1829