Base power = 0.166667, numbus = 23000, numgen = 1000, numyl = 15000, numdl = 3000, numlbr = 21999, numtbr = 1000 **** Power flow dist case **** Base power = 0.166667, nbus = 23000, ngen = 1000, nwye = 15000, ndelta = 3000, nbranch = 22999 0 SNES Function norm 508.442 Form Jacobian time: 117.156974 seconds 1 SNES Function norm 34.4031 Form Jacobian time: 0.112949 seconds 2 SNES Function norm 0.147587 Form Jacobian time: 0.114196 seconds 3 SNES Function norm 3.67544e-06 Form Jacobian time: 0.124189 seconds 4 SNES Function norm 1.58715e-09 Nonlinear solve converged due to CONVERGED_SNORM_RELATIVE iterations 4 SNES Object: 1 MPI processes type: newtonls maximum iterations=50, maximum function evaluations=10000 tolerances: relative=1e-20, absolute=1e-10, solution=1e-08 total number of linear solver iterations=4 total number of function evaluations=5 norm schedule ALWAYS SNESLineSearch Object: 1 MPI processes type: basic maxstep=1.000000e+08, minlambda=1.000000e-12 tolerances: relative=1.000000e-08, absolute=1.000000e-15, lambda=1.000000e-08 maximum iterations=40 using user-defined postcheck step KSP Object: 1 MPI processes type: gmres restart=30, using Classical (unmodified) Gram-Schmidt Orthogonalization with no iterative refinement happy breakdown tolerance 1e-30 maximum iterations=10000, initial guess is zero tolerances: relative=1e-05, absolute=1e-50, divergence=10000. left preconditioning using PRECONDITIONED norm type for convergence test PC Object: 1 MPI processes type: lu out-of-place factorization tolerance for zero pivot 2.22045e-14 matrix ordering: nd factor fill ratio given 5., needed 2.42922 Factored matrix follows: Mat Object: 1 MPI processes type: seqaij rows=124000, cols=124000 package used to perform factorization: petsc total: nonzeros=5271230, allocated nonzeros=5271230 total number of mallocs used during MatSetValues calls =0 using I-node routines: found 40650 nodes, limit used is 5 linear system matrix = precond matrix: Mat Object: 1 MPI processes type: seqaij rows=124000, cols=124000 total: nonzeros=2169928, allocated nonzeros=2309928 total number of mallocs used during MatSetValues calls =10000 using I-node routines: found 41000 nodes, limit used is 5 Total time elapsed: 118.512266 seconds ************************************************************************************************************************ *** WIDEN YOUR WINDOW TO 120 CHARACTERS. Use 'enscript -r -fCourier9' to print this document *** ************************************************************************************************************************ ---------------------------------------------- PETSc Performance Summary: ---------------------------------------------- ./dpflow on a arch-darwin-c-opt named jchang31606s.nrel.gov with 1 processor, by jchang Wed May 8 13:23:33 2019 Using Petsc Development GIT revision: v3.11.1-539-gaf5aa23e46 GIT Date: 2019-05-07 11:11:18 -0500 Max Max/Min Avg Total Time (sec): 1.185e+02 1.000 1.185e+02 Objects: 7.300e+01 1.000 7.300e+01 Flop: 3.587e+08 1.000 3.587e+08 3.587e+08 Flop/sec: 3.026e+06 1.000 3.026e+06 3.026e+06 MPI Messages: 0.000e+00 0.000 0.000e+00 0.000e+00 MPI Message Lengths: 0.000e+00 0.000 0.000e+00 0.000e+00 MPI Reductions: 0.000e+00 0.000 Flop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract) e.g., VecAXPY() for real vectors of length N --> 2N flop and VecAXPY() for complex vectors of length N --> 8N flop Summary of Stages: ----- Time ------ ----- Flop ------ --- Messages --- -- Message Lengths -- -- Reductions -- Avg %Total Avg %Total Count %Total Avg %Total Count %Total 0: Main Stage: 1.1819e+02 99.7% 3.5866e+08 100.0% 0.000e+00 0.0% 0.000e+00 0.0% 0.000e+00 0.0% 1: Read Data: 2.5696e-01 0.2% 0.0000e+00 0.0% 0.000e+00 0.0% 0.000e+00 0.0% 0.000e+00 0.0% 2: Create network: 6.4609e-02 0.1% 0.0000e+00 0.0% 0.000e+00 0.0% 0.000e+00 0.0% 0.000e+00 0.0% ------------------------------------------------------------------------------------------------------------------------ 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 1 1.0 2.1005e-04 1.0 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 4 1.0 7.5996e-03 1.0 1.69e+07 1.0 0.0e+00 0.0e+00 0.0e+00 0 5 0 0 0 0 5 0 0 0 2219 MatSolve 8 1.0 4.0087e-02 1.0 8.33e+07 1.0 0.0e+00 0.0e+00 0.0e+00 0 23 0 0 0 0 23 0 0 0 2079 MatLUFactorSym 1 1.0 8.0392e-02 1.0 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 MatLUFactorNum 4 1.0 1.7615e-01 1.0 2.48e+08 1.0 0.0e+00 0.0e+00 0.0e+00 0 69 0 0 0 0 69 0 0 0 1407 MatAssemblyBegin 5 1.0 0.0000e+00 0.0 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 5 1.0 1.2109e-02 1.0 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 MatGetRowIJ 1 1.0 1.0752e-02 1.0 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 MatGetOrdering 1 1.0 2.5593e-02 1.0 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 MatZeroEntries 4 1.0 2.7900e-03 1.0 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 MatView 2 1.0 2.0719e-04 1.0 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 DMPlexPrealloc 1 1.0 7.8915e-02 1.0 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 SFSetGraph 1 1.0 3.7909e-05 1.0 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 1 1.0 2.8360e-03 1.0 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 SFBcastBegin 14 1.0 5.1045e-03 1.0 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 SFBcastEnd 14 1.0 4.4861e-03 1.0 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 SFReduceBegin 6 1.0 2.2619e-03 1.0 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 6 1.0 1.7838e-03 1.0 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 VecMDot 4 1.0 4.2605e-04 1.0 9.92e+05 1.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 2328 VecNorm 9 1.0 3.8195e-04 1.0 2.23e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 5844 VecScale 8 1.0 2.8014e-04 1.0 9.92e+05 1.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 3541 VecCopy 8 1.0 7.1001e-04 1.0 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 32 1.0 6.6895e-03 1.0 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 4 1.0 2.9063e-04 1.0 9.92e+05 1.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 3413 VecWAXPY 4 1.0 6.0391e-04 1.0 4.96e+05 1.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 821 VecMAXPY 8 1.0 5.5718e-04 1.0 1.98e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3561 VecScatterBegin 1 1.0 5.0068e-05 1.0 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 VecReduceArith 12 1.0 5.9509e-04 1.0 2.98e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 5001 VecReduceComm 4 1.0 2.8610e-06 1.0 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 VecNormalize 8 1.0 6.3920e-04 1.0 2.98e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 4656 SNESSolve 1 1.0 1.1797e+02 1.0 3.59e+08 1.0 0.0e+00 0.0e+00 0.0e+00100100 0 0 0 100100 0 0 0 3 SNESFunctionEval 5 1.0 1.0488e-01 1.0 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 SNESJacobianEval 4 1.0 1.1751e+02 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 99 0 0 0 0 99 0 0 0 0 0 SNESLineSearch 4 1.0 9.2767e-02 1.0 3.47e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 37 KSPSetUp 4 1.0 3.2880e-03 1.0 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 KSPSolve 4 1.0 3.3595e-01 1.0 3.55e+08 1.0 0.0e+00 0.0e+00 0.0e+00 0 99 0 0 0 0 99 0 0 0 1057 KSPGMRESOrthog 4 1.0 7.9584e-04 1.0 1.98e+06 1.0 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2493 PCSetUp 4 1.0 2.8220e-01 1.0 2.48e+08 1.0 0.0e+00 0.0e+00 0.0e+00 0 69 0 0 0 0 69 0 0 0 878 PCApply 8 1.0 4.0098e-02 1.0 8.33e+07 1.0 0.0e+00 0.0e+00 0.0e+00 0 23 0 0 0 0 23 0 0 0 2079 --- Event Stage 1: Read Data --- Event Stage 2: Create network DMPlexStratify 1 1.0 5.7468e-03 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 9 0 0 0 0 0 VecSet 1 1.0 2.1696e-04 1.0 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 ------------------------------------------------------------------------------------------------------------------------ Memory usage is given in bytes: Object Type Creations Destructions Memory Descendants' Mem. Reports information only for process 0. --- Event Stage 0: Main Stage Container 0 1 584 0. Distributed Mesh 1 3 15824 0. DM Label 0 1 640 0. GraphPartitioner 0 1 664 0. Matrix 2 3 91663164 0. Index Set 6 9 1823204 0. IS L to G Mapping 1 1 496680 0. Section 4 12 8736 0. Star Forest Graph 4 7 5944 0. Discrete System 1 3 2784 0. Vector 13 14 13285616 0. SNES 1 1 1412 0. DMSNES 1 1 680 0. SNESLineSearch 1 1 1008 0. Krylov Solver 1 1 18648 0. DMKSP interface 1 1 664 0. Preconditioner 1 1 1008 0. Viewer 3 2 1696 0. Vec Scatter 1 1 776 0. --- Event Stage 1: Read Data --- Event Stage 2: Create network Container 1 0 0 0. Distributed Mesh 2 0 0 0. DM Label 1 0 0 0. GraphPartitioner 1 0 0 0. Matrix 1 0 0 0. Index Set 9 6 188796 0. Section 8 0 0 0. Star Forest Graph 4 1 840 0. Discrete System 3 1 928 0. Vector 1 0 0 0. ======================================================================================================================== Average time to get PetscTime(): 1.19209e-07 #PETSc Option Table entries: -input input/test_1000.m -ksp_type gmres -log_view -pc_type lu -petscpartitioner_type simple -snes_atol 1e-10 -snes_converged_reason -snes_linesearch_type basic -snes_monitor_short -snes_rtol 1e-20 -snes_type newtonls -snes_view #End of PETSc Option Table entries Compiled without FORTRAN kernels Compiled with full precision matrices (default) sizeof(short) 2 sizeof(int) 4 sizeof(long) 8 sizeof(void*) 8 sizeof(PetscScalar) 8 sizeof(PetscInt) 4 Configure options: --download-hdf5 --download-hypre --download-suitesparse --download-metis --download-ml --download-mumps --download-netcdf --download-parmetis --download-pnetcdf --download-scalapack --download-triangle --download-zlib --with-cc=mpicc --with-cxx=mpicxx --with-debugging=0 --with-fc=mpif90 --with-shared-libraries=1 COPTFLAGS=-O2 CXXOPTFLAGS=-O2 FOPTFLAGS=-O2 PETSC_ARCH=arch-darwin-c-opt ----------------------------------------- Libraries compiled on 2019-05-07 23:10:01 on jchang31606s.nrel.gov Machine characteristics: Darwin-16.7.0-x86_64-i386-64bit Using PETSc directory: /Users/jchang/Software/petsc Using PETSc arch: arch-darwin-c-opt ----------------------------------------- Using C compiler: mpicc -Wall -Wwrite-strings -Wno-strict-aliasing -Wno-unknown-pragmas -Qunused-arguments -fvisibility=hidden -O2 Using Fortran compiler: mpif90 -Wall -ffree-line-length-0 -Wno-unused-dummy-argument -O2 ----------------------------------------- Using include paths: -I/Users/jchang/Software/petsc/include -I/Users/jchang/Software/petsc/arch-darwin-c-opt/include -I/opt/X11/include ----------------------------------------- Using C linker: mpicc Using Fortran linker: mpif90 Using libraries: -Wl,-rpath,/Users/jchang/Software/petsc/arch-darwin-c-opt/lib -L/Users/jchang/Software/petsc/arch-darwin-c-opt/lib -lpetsc -Wl,-rpath,/Users/jchang/Software/petsc/arch-darwin-c-opt/lib -L/Users/jchang/Software/petsc/arch-darwin-c-opt/lib -Wl,-rpath,/opt/X11/lib -L/opt/X11/lib -Wl,-rpath,/usr/local/opt/libevent/lib -L/usr/local/opt/libevent/lib -Wl,-rpath,/usr/local/Cellar/open-mpi/3.1.2/lib -L/usr/local/Cellar/open-mpi/3.1.2/lib -Wl,-rpath,/usr/local/Cellar/gcc/8.2.0/lib/gcc/8/gcc/x86_64-apple-darwin16.7.0/8.2.0 -L/usr/local/Cellar/gcc/8.2.0/lib/gcc/8/gcc/x86_64-apple-darwin16.7.0/8.2.0 -Wl,-rpath,/usr/local/Cellar/gcc/8.2.0/lib/gcc/8 -L/usr/local/Cellar/gcc/8.2.0/lib/gcc/8 -Wl,-rpath,/Library/Developer/CommandLineTools/usr/lib/clang/9.0.0/lib/darwin -L/Library/Developer/CommandLineTools/usr/lib/clang/9.0.0/lib/darwin -lHYPRE -lcmumps -ldmumps -lsmumps -lzmumps -lmumps_common -lpord -lscalapack -lumfpack -lklu -lcholmod -lbtf -lccolamd -lcolamd -lcamd -lamd -lsuitesparseconfig -lml -llapack -lblas -lnetcdf -lpnetcdf -lhdf5hl_fortran -lhdf5_fortran -lhdf5_hl -lhdf5 -lparmetis -lmetis -ltriangle -lz -lX11 -lstdc++ -ldl -lmpi_usempif08 -lmpi_usempi_ignore_tkr -lmpi_mpifh -lmpi -lgfortran -lquadmath -lm -lc++ -ldl -lmpi -lclang_rt.osx -lstdc++ -ldl -----------------------------------------