MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.06-51-g8fb23ec17a58) initialized
Starting run at 18:42:38 UTC on 2022-06-30.
Successfully read inputs file ...
Castro git describe: 22.06-44-g18b3ffd36
AMReX git describe: 22.06-51-g8fb23ec17
Microphysics git describe: 22.06-7-ga6a75714
reading extern runtime parameters ...
3 Species:
C12 O16 Mg24
Successfully read inputs file ...
INITIAL GRIDS
Level 0 8 grids 262144 cells 100 % of domain
smallest grid: 32 x 32 x 32 biggest grid: 32 x 32 x 32
PLOTFILE: file = dustcollapse-3d-monopole_plt00000
Write plotfile time = 0.013966604 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.360987166
[STEP 1] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 1 TIME = 4.541742215e-05 DT = 4.541742215e-05
[Level 0 step 2] ADVANCE with dt = 4.768829326e-05
[Level 0 step 2] Advanced 262144 cells
[STEP 2] Coarse TimeStep time: 0.341508194
[STEP 2] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 2 TIME = 9.31057154e-05 DT = 4.768829326e-05
[Level 0 step 3] ADVANCE with dt = 5.007270792e-05
[Level 0 step 3] Advanced 262144 cells
[STEP 3] Coarse TimeStep time: 0.341412512
[STEP 3] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 3 TIME = 0.0001431784233 DT = 5.007270792e-05
[Level 0 step 4] ADVANCE with dt = 5.257634331e-05
[Level 0 step 4] Advanced 262144 cells
[STEP 4] Coarse TimeStep time: 0.342066269
[STEP 4] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 4 TIME = 0.0001957547666 DT = 5.257634331e-05
[Level 0 step 5] ADVANCE with dt = 5.520516048e-05
[Level 0 step 5] Advanced 262144 cells
[STEP 5] Coarse TimeStep time: 0.352362216
[STEP 5] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 5 TIME = 0.0002509599271 DT = 5.520516048e-05
[Level 0 step 6] ADVANCE with dt = 5.79654185e-05
[Level 0 step 6] Advanced 262144 cells
[STEP 6] Coarse TimeStep time: 0.348677344
[STEP 6] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 6 TIME = 0.0003089253456 DT = 5.79654185e-05
[Level 0 step 7] ADVANCE with dt = 6.086368943e-05
[Level 0 step 7] Advanced 262144 cells
[STEP 7] Coarse TimeStep time: 0.337377244
[STEP 7] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 7 TIME = 0.000369789035 DT = 6.086368943e-05
[Level 0 step 8] ADVANCE with dt = 6.39068739e-05
[Level 0 step 8] Advanced 262144 cells
[STEP 8] Coarse TimeStep time: 0.33488446
[STEP 8] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 8 TIME = 0.000433695909 DT = 6.39068739e-05
[Level 0 step 9] ADVANCE with dt = 6.71022176e-05
[Level 0 step 9] Advanced 262144 cells
[STEP 9] Coarse TimeStep time: 0.336810903
[STEP 9] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 9 TIME = 0.0005007981265 DT = 6.71022176e-05
[Level 0 step 10] ADVANCE with dt = 7.045732848e-05
[Level 0 step 10] Advanced 262144 cells
[STEP 10] Coarse TimeStep time: 0.336692054
[STEP 10] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 10 TIME = 0.000571255455 DT = 7.045732848e-05
PLOTFILE: file = dustcollapse-3d-monopole_plt00010
Write plotfile time = 0.00981849 seconds
Ending run at 18:42:42 UTC on 2022-06-30.
Run time = 3.632364963
Run time without initialization = 3.449108741
Average number of zones advanced per microsecond: 0.760
Average number of zones advanced per microsecond per rank: 0.095
TinyProfiler total time across processes [min...avg...max]: 3.63 ... 3.632 ... 3.632
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.1116 2.3871 2.4952 68.69%
Castro::do_advance_ctu() 10 0.02982 0.1416 0.4214 11.60%
Gravity::make_radial_gravity() 21 0.343 0.3559 0.3763 10.36%
Castro::initData() 1 0.03839 0.07934 0.119 3.28%
Castro::estTimeStep() 21 0.02935 0.06949 0.1109 3.05%
FabArray::ParallelCopy_finish() 41 0.04156 0.05981 0.1028 2.83%
FabArray::setVal() 143 0.06884 0.07253 0.07475 2.06%
Castro::reset_internal_energy(Fab) 1008 0.04688 0.05007 0.05294 1.46%
FabArray::ParallelCopy_nowait() 41 0.03077 0.04439 0.04953 1.36%
StateData::FillBoundary(geom) 41 0.03467 0.04245 0.04762 1.31%
Castro::normalize_species() 62 0.04125 0.04179 0.04215 1.16%
FillPatchIterator::Initialize 41 0.0226 0.03394 0.03818 1.05%
Gravity::interpolate_monopole_grav() 21 0.02708 0.02812 0.029 0.80%
Castro::construct_new_gravity_source() 10 0.02331 0.02407 0.02517 0.69%
Castro::expand_state() 10 0.01301 0.02013 0.02357 0.65%
Castro::computeTemp() 63 0.01758 0.01905 0.0203 0.56%
Castro::initialize_do_advance() 10 0.01447 0.01758 0.0187 0.51%
MultiFab::Saxpy() 20 0.0123 0.0152 0.01657 0.46%
VisMF::Write(FabArray) 2 0.01086 0.01201 0.01598 0.44%
Amr::writePlotFile() 2 0.008024 0.01202 0.01306 0.36%
MultiFab::contains_nan() 20 0.01028 0.01138 0.01258 0.35%
Gravity::get_new_grav_vector() 11 0.009668 0.01162 0.01257 0.35%
FabArray::setDomainBndry() 41 0.005588 0.01067 0.01249 0.34%
Castro::construct_old_gravity_source() 10 0.007148 0.01082 0.01243 0.34%
Castro::initialize_advance() 10 0.01058 0.01078 0.0112 0.31%
Gravity::get_old_grav_vector() 10 0.006331 0.009636 0.011 0.30%
Castro::construct_new_source() 50 0.00514 0.006643 0.007241 0.20%
Castro::enforce_min_density() 62 0.00654 0.006834 0.007212 0.20%
Castro::initMFs() 1 0.005609 0.006031 0.00674 0.19%
main() 1 0.003539 0.00541 0.00578 0.16%
StateData::define() 4 0.004617 0.004878 0.005148 0.14%
Castro::swap_state_time_levels() 10 0.003086 0.004064 0.004539 0.12%
Amr::coarseTimeStep() 10 0.0009175 0.001349 0.001752 0.05%
Castro::finalize_do_advance() 10 0.001118 0.001492 0.001647 0.05%
Castro::buildMetrics() 1 0.001318 0.001386 0.001498 0.04%
Amr::timeStep() 10 0.0001868 0.0002505 0.0005265 0.01%
Amr::InitAmr() 1 0.0002669 0.0002964 0.0003825 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002957 0.0003063 0.0003161 0.01%
Castro::clean_state() 62 0.0001367 0.0001628 0.000183 0.01%
StateDataPhysBCFunct::() 41 0.0001035 0.0001293 0.0001504 0.00%
DistributionMapping::LeastUsedCPUs() 1 6.615e-06 8.556e-05 0.0001126 0.00%
Castro::enforce_consistent_e() 1 8.156e-05 8.946e-05 0.0001015 0.00%
Castro::do_new_sources() 10 4.723e-05 7.735e-05 9.973e-05 0.00%
Amr::FinalizeInit() 1 3.841e-06 1.707e-05 9.772e-05 0.00%
Castro::construct_old_source() 50 3.233e-05 7.776e-05 9.663e-05 0.00%
FabArray::ParallelCopy() 41 7.89e-05 8.871e-05 9.434e-05 0.00%
Castro::Castro() 1 5.101e-05 7.064e-05 9.108e-05 0.00%
Castro::do_old_sources() 10 4.245e-05 6.996e-05 8.547e-05 0.00%
FillPatchSingleLevel 41 6.142e-05 6.883e-05 7.575e-05 0.00%
Amr::writeSmallPlotFile() 1 3.116e-05 6.121e-05 7.114e-05 0.00%
FabArrayBase::getCPC() 41 4.821e-05 6.039e-05 7.046e-05 0.00%
Castro::apply_source_to_state() 20 3.078e-05 5.188e-05 6.772e-05 0.00%
Castro::construct_old_gravity() 10 3.916e-05 5.458e-05 6.324e-05 0.00%
Castro::construct_new_gravity() 10 4.004e-05 4.845e-05 5.762e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.671e-05 4.677e-05 5.665e-05 0.00%
Castro::finalize_advance() 10 4.86e-05 5.32e-05 5.559e-05 0.00%
Castro::advance() 10 3.74e-05 4.269e-05 4.713e-05 0.00%
FabArrayBase::CPC::define() 2 2.347e-05 2.78e-05 3.519e-05 0.00%
Castro::enforce_speed_limit() 62 2.513e-05 2.955e-05 3.141e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.281e-05 1.996e-05 3.089e-05 0.00%
Castro::check_for_nan() 20 2.018e-05 2.212e-05 2.536e-05 0.00%
Amr::defBaseLevel() 1 1.763e-05 2.067e-05 2.47e-05 0.00%
Castro::post_timestep() 10 1.166e-05 1.372e-05 1.731e-05 0.00%
Gravity::swapTimeLevels() 10 6.798e-06 1.153e-05 1.511e-05 0.00%
Amr::init() 1 2.056e-06 3.931e-06 1.499e-05 0.00%
Castro::create_source_corrector() 10 7.27e-06 1.042e-05 1.316e-05 0.00%
Gravity::set_mass_offset() 10 7.23e-06 9.248e-06 1.122e-05 0.00%
Castro::FluxRegCrseInit 10 7.129e-06 9.36e-06 1.094e-05 0.00%
Castro::computeNewDt() 9 6.592e-06 8.658e-06 1.088e-05 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.61e-06 5.289e-06 9.414e-06 0.00%
Amr::initSubcycle() 1 8.024e-06 8.855e-06 9.254e-06 0.00%
Castro::retry_advance_ctu() 10 4.588e-06 6.047e-06 7.685e-06 0.00%
Amr::InitializeInit() 1 2.169e-06 3.645e-06 5.923e-06 0.00%
Castro::post_init() 1 3.271e-06 4.04e-06 5.253e-06 0.00%
Castro::computeInitialDt() 2 3.319e-06 4.065e-06 5.251e-06 0.00%
Castro::post_regrid() 1 1.577e-06 2.633e-06 4.417e-06 0.00%
Castro::FluxRegFineAdd() 10 2.158e-06 2.725e-06 3.256e-06 0.00%
Amr::initialInit() 1 1.096e-06 1.648e-06 2.303e-06 0.00%
DistributionMapping::Distribute() 1 8.98e-07 1.038e-06 1.176e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.63 3.632 3.632 100.00%
Amr::coarseTimeStep() 10 3.434 3.434 3.434 94.52%
Amr::timeStep() 10 3.424 3.424 3.425 94.28%
Castro::advance() 10 3.408 3.408 3.408 93.83%
Castro::subcycle_advance_ctu() 10 3.332 3.335 3.34 91.95%
Castro::do_advance_ctu() 10 3.332 3.335 3.34 91.95%
Castro::construct_ctu_hydro_source() 10 2.112 2.387 2.495 68.69%
Gravity::make_radial_gravity() 21 0.343 0.3559 0.3763 10.36%
Gravity::get_new_grav_vector() 11 0.2312 0.2328 0.2339 6.44%
Castro::construct_old_gravity() 10 0.2054 0.2154 0.2301 6.33%
Gravity::get_old_grav_vector() 10 0.2045 0.2145 0.229 6.31%
Castro::construct_new_gravity() 10 0.2046 0.2059 0.2068 5.69%
FillPatchIterator::Initialize 41 0.1822 0.1916 0.1993 5.49%
Castro::initialize_do_advance() 10 0.1649 0.1759 0.1833 5.05%
Amr::init() 1 0.1827 0.1828 0.1828 5.03%
FillPatchSingleLevel 41 0.1322 0.147 0.1707 4.70%
Amr::initialInit() 1 0.1684 0.1687 0.1689 4.65%
Amr::InitializeInit() 1 0.0569 0.09832 0.1386 3.82%
Amr::defBaseLevel() 1 0.0569 0.09832 0.1386 3.82%
Castro::expand_state() 10 0.1199 0.1275 0.1338 3.68%
FabArray::ParallelCopy() 41 0.08888 0.1044 0.1338 3.68%
Castro::initData() 1 0.04275 0.08339 0.1226 3.37%
Castro::clean_state() 62 0.1125 0.1173 0.1211 3.33%
Amr::FinalizeInit() 1 0.03012 0.07035 0.1119 3.08%
Castro::estTimeStep() 21 0.02935 0.06949 0.1109 3.05%
FabArray::ParallelCopy_finish() 41 0.04156 0.05981 0.1028 2.83%
Castro::computeInitialDt() 2 0.001619 0.0419 0.08335 2.29%
Castro::initialize_advance() 10 0.06781 0.07338 0.07576 2.09%
FabArray::setVal() 143 0.06884 0.07253 0.07475 2.06%
Castro::computeTemp() 63 0.06477 0.06943 0.07354 2.02%
Castro::do_new_sources() 10 0.0651 0.06608 0.06774 1.86%
Castro::reset_internal_energy(MultiFab) 63 0.04719 0.05038 0.05324 1.47%
Castro::reset_internal_energy(Fab) 1008 0.04688 0.05007 0.05294 1.46%
Castro::do_old_sources() 10 0.03861 0.04699 0.05037 1.39%
FabArray::ParallelCopy_nowait() 41 0.03088 0.04448 0.04961 1.37%
StateDataPhysBCFunct::() 41 0.03479 0.04258 0.04777 1.32%
StateData::FillBoundary(geom) 41 0.03467 0.04245 0.04762 1.31%
Castro::normalize_species() 62 0.04125 0.04179 0.04215 1.16%
Castro::construct_new_source() 50 0.03031 0.03071 0.03109 0.86%
Gravity::interpolate_monopole_grav() 21 0.02708 0.02812 0.029 0.80%
Castro::post_init() 1 0.02748 0.02772 0.02791 0.77%
Castro::construct_new_gravity_source() 10 0.02331 0.02407 0.02517 0.69%
Amr::writePlotFile() 2 0.02386 0.02404 0.02428 0.67%
Castro::apply_source_to_state() 20 0.01233 0.01525 0.01664 0.46%
MultiFab::Saxpy() 20 0.0123 0.0152 0.01657 0.46%
Castro::post_timestep() 10 0.01559 0.0159 0.01634 0.45%
VisMF::Write(FabArray) 2 0.01086 0.01201 0.01598 0.44%
Castro::check_for_nan() 20 0.0103 0.0114 0.01261 0.35%
MultiFab::contains_nan() 20 0.01028 0.01138 0.01258 0.35%
Castro::construct_old_source() 50 0.00718 0.01089 0.01252 0.34%
FabArray::setDomainBndry() 41 0.005588 0.01067 0.01249 0.34%
Castro::construct_old_gravity_source() 10 0.007148 0.01082 0.01243 0.34%
Castro::Castro() 1 0.009355 0.009914 0.01073 0.30%
Castro::enforce_min_density() 62 0.00654 0.006834 0.007212 0.20%
Castro::computeNewDt() 9 0.00701 0.007027 0.007039 0.19%
Castro::initMFs() 1 0.005609 0.006031 0.00674 0.19%
AmrLevel::AmrLevel(dm) 1 0.004638 0.004898 0.005164 0.14%
StateData::define() 4 0.004617 0.004878 0.005148 0.14%
Castro::swap_state_time_levels() 10 0.003086 0.004064 0.004539 0.12%
Castro::post_regrid() 1 0.001507 0.001628 0.001856 0.05%
Castro::buildMetrics() 1 0.001439 0.001517 0.00165 0.05%
Castro::finalize_do_advance() 10 0.001118 0.001492 0.001647 0.05%
Amr::InitAmr() 1 0.0002756 0.0003052 0.0003906 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.115e-05 9.189e-05 0.0001231 0.00%
DistributionMapping::LeastUsedCPUs() 1 6.615e-06 8.556e-05 0.0001126 0.00%
Castro::enforce_consistent_e() 1 8.156e-05 8.946e-05 0.0001015 0.00%
FabArrayBase::getCPC() 41 7.168e-05 8.819e-05 0.0001015 0.00%
Amr::writeSmallPlotFile() 1 3.116e-05 6.121e-05 7.114e-05 0.00%
Castro::finalize_advance() 10 5.848e-05 6.529e-05 6.897e-05 0.00%
FabArrayBase::CPC::define() 2 2.347e-05 2.78e-05 3.519e-05 0.00%
Castro::enforce_speed_limit() 62 2.513e-05 2.955e-05 3.141e-05 0.00%
Gravity::swapTimeLevels() 10 6.798e-06 1.153e-05 1.511e-05 0.00%
Castro::create_source_corrector() 10 7.27e-06 1.042e-05 1.316e-05 0.00%
Gravity::set_mass_offset() 10 7.23e-06 9.248e-06 1.122e-05 0.00%
Castro::FluxRegCrseInit 10 7.129e-06 9.36e-06 1.094e-05 0.00%
Amr::initSubcycle() 1 8.024e-06 8.855e-06 9.254e-06 0.00%
Castro::retry_advance_ctu() 10 4.588e-06 6.047e-06 7.685e-06 0.00%
Castro::FluxRegFineAdd() 10 2.158e-06 2.725e-06 3.256e-06 0.00%
DistributionMapping::Distribute() 1 8.98e-07 1.038e-06 1.176e-06 0.00%
-------------------------------------------------------------------------------------------
Unused ParmParse Variables:
[TOP]::amr.ref_ratio(nvals = 4) :: [2, 2, 2, 2]
[TOP]::amr.regrid_int(nvals = 4) :: [2, 2, 2, 2]
AMReX (22.06-51-g8fb23ec17a58) finalized