MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.07-5-g557aae84902f) initialized
Starting run at 05:38:11 UTC on 2022-07-07.
Successfully read inputs file ...
Castro git describe: 22.07-1-g2377b4709
AMReX git describe: 22.07-5-g557aae849
Microphysics git describe: 22.07-6-g94202288
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.013947329 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.357519612
[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.339623826
[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.33942237
[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.338314832
[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.350366489
[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.346507448
[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.335578133
[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.336828374
[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.335055508
[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.338271821
[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.009462427 seconds
Ending run at 05:38:14 UTC on 2022-07-07.
Run time = 3.61592357
Run time without initialization = 3.433041216
Average number of zones advanced per microsecond: 0.764
Average number of zones advanced per microsecond per rank: 0.095
TinyProfiler total time across processes [min...avg...max]: 3.614 ... 3.616 ... 3.616
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.1153 2.3913 2.4894 68.84%
Castro::do_advance_ctu() 10 0.03467 0.135 0.4137 11.44%
Gravity::make_radial_gravity() 21 0.3435 0.358 0.3821 10.57%
Castro::initData() 1 0.03853 0.08096 0.1183 3.27%
FabArray::ParallelCopy_finish() 41 0.03946 0.05924 0.1181 3.27%
Castro::estTimeStep() 21 0.0275 0.06748 0.1085 3.00%
FabArray::setVal() 143 0.05941 0.06849 0.07123 1.97%
Castro::reset_internal_energy(Fab) 1008 0.04753 0.05068 0.05275 1.46%
FabArray::ParallelCopy_nowait() 41 0.02633 0.04316 0.04881 1.35%
StateData::FillBoundary(geom) 41 0.03459 0.04201 0.04587 1.27%
Castro::normalize_species() 62 0.04144 0.04181 0.04269 1.18%
FillPatchIterator::Initialize 41 0.02138 0.03318 0.03764 1.04%
Gravity::interpolate_monopole_grav() 21 0.02694 0.02769 0.02824 0.78%
Castro::construct_new_gravity_source() 10 0.01953 0.02303 0.0243 0.67%
Castro::expand_state() 10 0.009737 0.01845 0.0218 0.60%
Castro::computeTemp() 63 0.01816 0.01937 0.02038 0.56%
Castro::initialize_do_advance() 10 0.009194 0.01655 0.01847 0.51%
MultiFab::Saxpy() 20 0.008581 0.01422 0.01608 0.44%
VisMF::Write(FabArray) 2 0.01125 0.01196 0.0156 0.43%
Gravity::get_new_grav_vector() 11 0.007159 0.01112 0.01284 0.36%
MultiFab::contains_nan() 20 0.009345 0.01092 0.01239 0.34%
Amr::writePlotFile() 2 0.008027 0.01138 0.01238 0.34%
FabArray::setDomainBndry() 41 0.004899 0.01036 0.01232 0.34%
Castro::construct_old_gravity_source() 10 0.004915 0.01005 0.01197 0.33%
Gravity::get_old_grav_vector() 10 0.005634 0.009348 0.0109 0.30%
Castro::initialize_advance() 10 0.006273 0.009758 0.01053 0.29%
Castro::enforce_min_density() 62 0.006137 0.00676 0.007261 0.20%
Castro::initMFs() 1 0.00555 0.006028 0.00713 0.20%
Castro::construct_new_source() 50 0.004861 0.00645 0.007031 0.19%
StateData::define() 4 0.004579 0.005236 0.006813 0.19%
main() 1 0.003323 0.004948 0.005344 0.15%
Castro::swap_state_time_levels() 10 0.002878 0.003727 0.004302 0.12%
Amr::coarseTimeStep() 10 0.001024 0.001702 0.002444 0.07%
Castro::buildMetrics() 1 0.001328 0.001412 0.001474 0.04%
Castro::finalize_do_advance() 10 0.0005254 0.00109 0.001259 0.03%
Amr::InitAmr() 1 0.000265 0.0003618 0.0005199 0.01%
Amr::timeStep() 10 0.0001763 0.0002338 0.0004931 0.01%
DistributionMapping::LeastUsedCPUs() 1 9.341e-06 0.0002199 0.0003446 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0003024 0.0003104 0.0003182 0.01%
Castro::clean_state() 62 0.000149 0.0001575 0.0001771 0.00%
StateDataPhysBCFunct::() 41 0.0001157 0.0001327 0.0001564 0.00%
Castro::do_new_sources() 10 4.44e-05 7.418e-05 9.819e-05 0.00%
FabArray::ParallelCopy() 41 7.292e-05 8.832e-05 9.725e-05 0.00%
Castro::enforce_consistent_e() 1 7.606e-05 8.583e-05 9.638e-05 0.00%
Castro::construct_old_source() 50 3.084e-05 7.17e-05 9.55e-05 0.00%
Castro::Castro() 1 5.553e-05 6.932e-05 8.701e-05 0.00%
Castro::apply_source_to_state() 20 3.597e-05 5.749e-05 8.61e-05 0.00%
Castro::do_old_sources() 10 3.805e-05 6.996e-05 8.344e-05 0.00%
FillPatchSingleLevel 41 6.246e-05 6.716e-05 7.121e-05 0.00%
Amr::writeSmallPlotFile() 1 3.156e-05 5.876e-05 6.944e-05 0.00%
Amr::FinalizeInit() 1 3.74e-06 1.246e-05 6.854e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.782e-05 4.815e-05 6.579e-05 0.00%
FabArrayBase::getCPC() 41 5.379e-05 5.796e-05 6.538e-05 0.00%
Castro::construct_old_gravity() 10 3.821e-05 5.538e-05 6.499e-05 0.00%
Castro::finalize_advance() 10 5.077e-05 5.453e-05 5.986e-05 0.00%
Castro::construct_new_gravity() 10 3.724e-05 4.522e-05 4.963e-05 0.00%
Castro::advance() 10 3.568e-05 4.312e-05 4.882e-05 0.00%
Amr::defBaseLevel() 1 1.72e-05 2.281e-05 3.762e-05 0.00%
Castro::enforce_speed_limit() 62 2.722e-05 3.177e-05 3.432e-05 0.00%
FabArrayBase::CPC::define() 2 2.234e-05 2.68e-05 3.42e-05 0.00%
Castro::check_for_nan() 20 2.097e-05 2.28e-05 2.424e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.322e-05 1.682e-05 2.255e-05 0.00%
Castro::FluxRegCrseInit 10 5.617e-06 1.148e-05 1.748e-05 0.00%
Amr::initSubcycle() 1 8.195e-06 1.096e-05 1.691e-05 0.00%
Castro::post_timestep() 10 1.064e-05 1.328e-05 1.642e-05 0.00%
Gravity::swapTimeLevels() 10 5.485e-06 1.259e-05 1.634e-05 0.00%
Castro::create_source_corrector() 10 6.62e-06 1.061e-05 1.413e-05 0.00%
Gravity::set_mass_offset() 10 7.077e-06 9.415e-06 1.087e-05 0.00%
Castro::computeNewDt() 9 6.71e-06 9.026e-06 1.055e-05 0.00%
Amr::InitializeInit() 1 2.131e-06 4.459e-06 8.356e-06 0.00%
Castro::retry_advance_ctu() 10 5.664e-06 7.161e-06 7.908e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.932e-06 4.672e-06 5.82e-06 0.00%
Castro::computeInitialDt() 2 3.872e-06 4.415e-06 4.924e-06 0.00%
Castro::post_regrid() 1 1.605e-06 3.23e-06 4.915e-06 0.00%
Castro::post_init() 1 2.708e-06 3.299e-06 3.905e-06 0.00%
Castro::FluxRegFineAdd() 10 2.009e-06 2.356e-06 2.969e-06 0.00%
Amr::init() 1 1.778e-06 2.018e-06 2.409e-06 0.00%
Amr::initialInit() 1 1.142e-06 1.598e-06 2.225e-06 0.00%
DistributionMapping::Distribute() 1 1.026e-06 1.182e-06 1.596e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.614 3.616 3.616 100.00%
Amr::coarseTimeStep() 10 3.418 3.418 3.418 94.53%
Amr::timeStep() 10 3.408 3.408 3.409 94.28%
Castro::advance() 10 3.391 3.392 3.392 93.81%
Castro::subcycle_advance_ctu() 10 3.319 3.322 3.329 92.07%
Castro::do_advance_ctu() 10 3.319 3.321 3.329 92.07%
Castro::construct_ctu_hydro_source() 10 2.115 2.391 2.489 68.84%
Gravity::make_radial_gravity() 21 0.3435 0.358 0.3821 10.57%
Gravity::get_new_grav_vector() 11 0.2304 0.2325 0.234 6.47%
Castro::construct_old_gravity() 10 0.203 0.2153 0.233 6.44%
Gravity::get_old_grav_vector() 10 0.2021 0.2144 0.2325 6.43%
FillPatchIterator::Initialize 41 0.1794 0.1883 0.2084 5.76%
Castro::construct_new_gravity() 10 0.2036 0.205 0.2062 5.70%
Amr::init() 1 0.1822 0.1824 0.1825 5.05%
FillPatchSingleLevel 41 0.13 0.1448 0.1821 5.04%
Castro::initialize_do_advance() 10 0.1596 0.171 0.1783 4.93%
Amr::initialInit() 1 0.168 0.1686 0.169 4.67%
FabArray::ParallelCopy() 41 0.08665 0.1026 0.1446 4.00%
Amr::InitializeInit() 1 0.0578 0.1001 0.1381 3.82%
Amr::defBaseLevel() 1 0.0578 0.1001 0.1381 3.82%
Castro::expand_state() 10 0.1161 0.1236 0.1291 3.57%
Castro::initData() 1 0.04224 0.08488 0.1222 3.38%
Castro::clean_state() 62 0.1134 0.1182 0.1214 3.36%
FabArray::ParallelCopy_finish() 41 0.03946 0.05924 0.1181 3.27%
Amr::FinalizeInit() 1 0.03046 0.06844 0.111 3.07%
Castro::estTimeStep() 21 0.0275 0.06748 0.1085 3.00%
Castro::computeInitialDt() 2 0.001859 0.03968 0.08209 2.27%
Castro::initialize_advance() 10 0.06214 0.07039 0.07274 2.01%
Castro::computeTemp() 63 0.066 0.07036 0.07256 2.01%
FabArray::setVal() 143 0.05941 0.06849 0.07123 1.97%
Castro::do_new_sources() 10 0.0533 0.06322 0.06554 1.81%
Castro::reset_internal_energy(MultiFab) 63 0.04783 0.05099 0.05307 1.47%
Castro::reset_internal_energy(Fab) 1008 0.04753 0.05068 0.05275 1.46%
Castro::do_old_sources() 10 0.03355 0.04553 0.04915 1.36%
FabArray::ParallelCopy_nowait() 41 0.02642 0.04324 0.04889 1.35%
StateDataPhysBCFunct::() 41 0.0347 0.04214 0.046 1.27%
StateData::FillBoundary(geom) 41 0.03459 0.04201 0.04587 1.27%
Castro::normalize_species() 62 0.04144 0.04181 0.04269 1.18%
Castro::construct_new_source() 50 0.02439 0.02948 0.0313 0.87%
Castro::post_init() 1 0.02782 0.02818 0.02851 0.79%
Gravity::interpolate_monopole_grav() 21 0.02694 0.02769 0.02824 0.78%
Castro::construct_new_gravity_source() 10 0.01953 0.02303 0.0243 0.67%
Amr::writePlotFile() 2 0.02308 0.02334 0.02367 0.65%
Castro::post_timestep() 10 0.01577 0.01616 0.01677 0.46%
Castro::apply_source_to_state() 20 0.008617 0.01427 0.01614 0.45%
MultiFab::Saxpy() 20 0.008581 0.01422 0.01608 0.44%
VisMF::Write(FabArray) 2 0.01125 0.01196 0.0156 0.43%
Castro::check_for_nan() 20 0.009366 0.01094 0.01242 0.34%
MultiFab::contains_nan() 20 0.009345 0.01092 0.01239 0.34%
FabArray::setDomainBndry() 41 0.004899 0.01036 0.01232 0.34%
Castro::construct_old_source() 50 0.004946 0.01012 0.01205 0.33%
Castro::construct_old_gravity_source() 10 0.004915 0.01005 0.01197 0.33%
Castro::Castro() 1 0.008851 0.009757 0.01046 0.29%
Castro::enforce_min_density() 62 0.006137 0.00676 0.007261 0.20%
Castro::initMFs() 1 0.00555 0.006028 0.00713 0.20%
Castro::computeNewDt() 9 0.007064 0.007071 0.007079 0.20%
AmrLevel::AmrLevel(dm) 1 0.004592 0.005253 0.006835 0.19%
StateData::define() 4 0.004579 0.005236 0.006813 0.19%
Castro::swap_state_time_levels() 10 0.002878 0.003727 0.004302 0.12%
Castro::post_regrid() 1 0.001524 0.001641 0.001955 0.05%
Castro::buildMetrics() 1 0.001445 0.001546 0.001616 0.04%
Castro::finalize_do_advance() 10 0.0005254 0.00109 0.001259 0.03%
Amr::InitAmr() 1 0.0002738 0.0003728 0.0005368 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.576e-05 0.0002257 0.0003513 0.01%
DistributionMapping::LeastUsedCPUs() 1 9.341e-06 0.0002199 0.0003446 0.01%
FabArrayBase::getCPC() 41 7.705e-05 8.477e-05 9.959e-05 0.00%
Castro::enforce_consistent_e() 1 7.606e-05 8.583e-05 9.638e-05 0.00%
Castro::finalize_advance() 10 6.122e-05 6.836e-05 7.609e-05 0.00%
Amr::writeSmallPlotFile() 1 3.156e-05 5.876e-05 6.944e-05 0.00%
Castro::enforce_speed_limit() 62 2.722e-05 3.177e-05 3.432e-05 0.00%
FabArrayBase::CPC::define() 2 2.234e-05 2.68e-05 3.42e-05 0.00%
Castro::FluxRegCrseInit 10 5.617e-06 1.148e-05 1.748e-05 0.00%
Amr::initSubcycle() 1 8.195e-06 1.096e-05 1.691e-05 0.00%
Gravity::swapTimeLevels() 10 5.485e-06 1.259e-05 1.634e-05 0.00%
Castro::create_source_corrector() 10 6.62e-06 1.061e-05 1.413e-05 0.00%
Gravity::set_mass_offset() 10 7.077e-06 9.415e-06 1.087e-05 0.00%
Castro::retry_advance_ctu() 10 5.664e-06 7.161e-06 7.908e-06 0.00%
Castro::FluxRegFineAdd() 10 2.009e-06 2.356e-06 2.969e-06 0.00%
DistributionMapping::Distribute() 1 1.026e-06 1.182e-06 1.596e-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.07-5-g557aae84902f) finalized