[petsc-users] Bug in log_view printing

Jared Crean jcrean01 at gmail.com
Sun Jul 16 10:45:22 CDT 2023


Hello,

   I stumbled upon a small bug in the printing of the data when running 
Petsc with -log_view.  The entire table is attached, but here is an 
example row:

------------------------------------------------------------------------------------------------------------------------
Event                Count      Time (sec) 
Flop                              --- Global ---  --- Stage ---- Total
                    Max Ratio  Max     Ratio   Max  Ratio  Mess AvgLen  
Reduct  %T %F %M %L %R  %T %F %M %L %R Mflop/s
------------------------------------------------------------------------------------------------------------------------

--- Event Stage 0: Main Stage

BuildTwoSided          7 1.0 1.3282e-0271.6 0.00e+00 0.0 6.0e+01 4.0e+00 
5.0e+00  0  0  0  0  0   0  0  0  0  0     0


   Notice how the Time Max and Time Ratio values are missing a space 
separator (the other rows have only two digits for the exponents, I 
think there should be a space after the e-02 and before the 7).

   Configuration details:

     * Petsc 3.17

     * Arm64 architecture (and AWS c7g.xlarge instance, which use the 
new Graviton3 processor)

     * ubuntu 22.04

     * MPICH MPI (version 4.0, I think, whatever apt-get install mpich 
gives)

     * clang-15 compiler


   Jared Crean

-------------- next part --------------
------------------------------------------------------------------------------------------------------------------------
See the 'Profiling' chapter of the users' manual for details on interpreting output.
Phase summary info:
   Count: number of times phase was executed
   Time and Flop: Max - maximum over all processors
                  Ratio - ratio of maximum to minimum over all processors
   Mess: number of messages sent
   AvgLen: average message length (bytes)
   Reduct: number of global reductions
   Global: entire computation
   Stage: stages of a computation. Set stages with PetscLogStagePush() and PetscLogStagePop().
      %T - percent time in this phase         %F - percent flop in this phase
      %M - percent messages in this phase     %L - percent message lengths in this phase
      %R - percent reductions in this phase
   Total Mflop/s: 10e-6 * (sum of flop over all processors)/(max time over all processors)
------------------------------------------------------------------------------------------------------------------------
Event                Count      Time (sec)     Flop                              --- Global ---  --- Stage ----  Total
                   Max Ratio  Max     Ratio   Max  Ratio  Mess   AvgLen  Reduct  %T %F %M %L %R  %T %F %M %L %R Mflop/s
------------------------------------------------------------------------------------------------------------------------

--- Event Stage 0: Main Stage

BuildTwoSided          7 1.0 1.3282e-0271.6 0.00e+00 0.0 6.0e+01 4.0e+00 5.0e+00  0  0  0  0  0   0  0  0  0  0     0
VecTDot             6852 1.0 4.5610e-01 4.2 1.70e+08 1.1 0.0e+00 0.0e+00 6.9e+03  1  2  0  0 30   1  2  0  0 30  1434
VecNorm             3721 1.0 2.8767e+00143.9 9.22e+07 1.1 0.0e+00 0.0e+00 3.7e+03  8  1  0  0 16   8  1  0  0 16   123
VecCopy              590 1.0 3.3962e-03 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
VecSet             11458 1.0 5.3920e-02 1.9 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
VecAXPY             6852 1.0 3.8920e-02 1.1 1.70e+08 1.1 0.0e+00 0.0e+00 0.0e+00  0  2  0  0  0   0  2  0  0  0 16807
VecAYPX             3131 1.0 2.4083e-02 1.4 7.75e+07 1.1 0.0e+00 0.0e+00 0.0e+00  0  1  0  0  0   0  1  0  0  0 12411
VecScatterBegin    18605 1.0 2.1698e-01 1.1 0.00e+00 0.0 8.9e+04 2.6e+04 3.0e+00  1  0 94 43  0   1  0 94 43  0     0
VecScatterEnd      18605 1.0 5.6709e+00 9.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 16  0  0  0  0  16  0  0  0  0     0
SFSetGraph             7 1.0 1.3217e-03 3.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
SFSetUp                7 1.0 1.3869e-02 6.2 0.00e+00 0.0 1.2e+02 5.6e+03 5.0e+00  0  0  0  0  0   0  0  0  0  0     0
SFReduceBegin       3721 1.0 1.9801e-02 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
SFReduceEnd         3721 1.0 1.6752e-03 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
SFPack             18605 1.0 8.0476e-02 4.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
SFUnpack           18605 1.0 5.8449e-03 3.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatMult             3426 1.0 9.8399e-01 1.2 2.33e+09 1.1 4.1e+04 2.7e+04 1.0e+00  3 23 43 21  0   3 23 43 21  0  8914
MatSolve            3721 1.0 4.1004e+00 3.3 9.53e+09 3.7 0.0e+00 0.0e+00 0.0e+00  8 44  0  0  0   8 44  0  0  0  4227
MatLUFactorNum       295 1.0 3.6820e+00 3.7 5.19e+09 3.9 0.0e+00 0.0e+00 0.0e+00  6 24  0  0  0   6 24  0  0  0  2528
MatILUFactorSym        1 1.0 4.1936e-03 3.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatConvert             2 1.0 2.7529e-03 1.2 0.00e+00 0.0 4.8e+01 6.7e+03 2.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatAssemblyBegin     592 1.0 2.3646e-04 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatAssemblyEnd       592 1.0 1.1952e-02 1.9 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatGetRowIJ            1 1.0 2.0600e-07 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatCreateSubMats     295 1.0 4.9069e+00 1.5 0.00e+00 0.0 3.6e+03 7.9e+05 1.0e+00 14  0  4 53  0  14  0  4 53  0     0
MatGetOrdering         1 1.0 9.3876e-05 4.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatIncreaseOvrlp       1 1.0 1.9540e-03 2.5 0.00e+00 0.0 0.0e+00 0.0e+00 1.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatZeroEntries       295 1.0 2.3006e-02 1.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00  0  0  0  0  0   0  0  0  0  0     0
MatAXPY              588 1.0 1.3316e-01 1.6 4.07e+08 1.1 0.0e+00 0.0e+00 0.0e+00  0  4  0  0  0   0  4  0  0  0 11516
KSPSetUp             296 1.0 1.1351e-03 9.2 0.00e+00 0.0 0.0e+00 0.0e+00 2.0e+00  0  0  0  0  0   0  0  0  0  0     0
KSPSolve             295 1.0 1.1427e+01 1.9 1.23e+10 2.4 8.6e+04 2.7e+04 1.1e+04 39 72 90 43 47  39 72 90 43 47  2456
PCSetUp              590 1.0 8.6008e+00 2.0 5.19e+09 3.9 3.6e+03 7.9e+05 7.0e+00 21 24  4 53  0  21 24  4 53  0  1082
PCSetUpOnBlocks      295 1.0 3.7052e+00 3.7 5.19e+09 3.9 0.0e+00 0.0e+00 0.0e+00  7 24  0  0  0   7 24  0  0  0  2512
PCApply             3721 1.0 7.1734e+00 1.5 9.53e+09 3.7 4.5e+04 2.7e+04 1.0e+00 25 44 47 22  0  25 44 47 22  0  2416
PCApplyOnBlocks     3721 1.0 4.1748e+00 2.9 9.53e+09 3.7 0.0e+00 0.0e+00 0.0e+00  8 44  0  0  0   8 44  0  0  0  4152
------------------------------------------------------------------------------------------------------------------------


More information about the petsc-users mailing list