MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.09-9-g67384701a808) initialized
Starting run at 05:39:21 UTC on 2022-09-08.
Successfully read inputs file ...
Castro git describe: 22.09
AMReX git describe: 22.09-9-g67384701a
Microphysics git describe: 22.08-12-g91211ba4
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.016105731 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.356342975
[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.343240789
[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.342173669
[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.362848103
[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.359188733
[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.355065175
[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.341197208
[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.341273532
[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.340740223
[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.342197819
[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.010316162 seconds
Ending run at 05:39:24 UTC on 2022-09-08.
Run time = 3.693018218
Run time without initialization = 3.502587923
Average number of zones advanced per microsecond: 0.748
Average number of zones advanced per microsecond per rank: 0.094
TinyProfiler total time across processes [min...avg...max]: 3.69 ... 3.693 ... 3.693
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.0975 2.4263 2.5468 68.96%
Castro::do_advance_ctu() 10 0.03884 0.1581 0.4897 13.26%
Gravity::make_radial_gravity() 21 0.3414 0.3553 0.3837 10.39%
FabArray::ParallelCopy_finish() 41 0.04241 0.06455 0.1252 3.39%
Castro::estTimeStep() 21 0.02902 0.07255 0.1217 3.30%
Castro::initData() 1 0.0396 0.07907 0.1198 3.24%
FabArray::setVal() 143 0.06176 0.06985 0.07186 1.95%
Castro::reset_internal_energy(Fab) 1008 0.0455 0.0497 0.05194 1.41%
FabArray::ParallelCopy_nowait() 41 0.02782 0.04485 0.0498 1.35%
StateData::FillBoundary(geom) 41 0.03432 0.04188 0.04622 1.25%
Castro::normalize_species() 62 0.04066 0.04162 0.0429 1.16%
FillPatchIterator::Initialize 41 0.02462 0.03582 0.03983 1.08%
Gravity::interpolate_monopole_grav() 21 0.02639 0.02746 0.02791 0.76%
Castro::construct_new_gravity_source() 10 0.02024 0.02293 0.02379 0.64%
Castro::expand_state() 10 0.009801 0.01891 0.02297 0.62%
Castro::computeTemp() 63 0.01709 0.01888 0.01989 0.54%
Castro::initialize_do_advance() 10 0.01013 0.01727 0.01882 0.51%
VisMF::Write(FabArray) 2 0.01313 0.01389 0.01828 0.49%
MultiFab::Saxpy() 20 0.00863 0.01426 0.01588 0.43%
Amr::writePlotFile() 2 0.008384 0.01312 0.01411 0.38%
Gravity::get_new_grav_vector() 11 0.007537 0.01136 0.01267 0.34%
FabArray::setDomainBndry() 41 0.004847 0.01051 0.0124 0.34%
MultiFab::contains_nan() 20 0.009488 0.01105 0.01223 0.33%
Castro::construct_old_gravity_source() 10 0.004972 0.01012 0.01171 0.32%
Gravity::get_old_grav_vector() 10 0.005689 0.009384 0.0108 0.29%
Castro::initialize_advance() 10 0.006739 0.009912 0.01068 0.29%
Castro::initMFs() 1 0.006608 0.00689 0.008717 0.24%
Castro::enforce_min_density() 62 0.006103 0.006718 0.007221 0.20%
Castro::construct_new_source() 50 0.004701 0.006483 0.007082 0.19%
main() 1 0.004417 0.006509 0.007078 0.19%
StateData::define() 4 0.005552 0.005656 0.006319 0.17%
Castro::swap_state_time_levels() 10 0.002582 0.004304 0.004585 0.12%
Amr::coarseTimeStep() 10 0.001142 0.001738 0.002675 0.07%
Castro::buildMetrics() 1 0.001568 0.001616 0.001865 0.05%
Castro::finalize_do_advance() 10 0.0006578 0.001437 0.001758 0.05%
Amr::timeStep() 10 0.0001769 0.0002445 0.00045 0.01%
Amr::InitAmr() 1 0.0002599 0.0002928 0.0004044 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002831 0.0002938 0.000307 0.01%
Castro::clean_state() 62 0.0001558 0.0001759 0.0002188 0.01%
DistributionMapping::LeastUsedCPUs() 1 6.79e-06 0.0001285 0.0001575 0.00%
StateDataPhysBCFunct::() 41 0.0001191 0.0001265 0.0001394 0.00%
Castro::enforce_consistent_e() 1 7.783e-05 8.803e-05 0.0001068 0.00%
FabArray::ParallelCopy() 41 8.117e-05 9.042e-05 0.0001005 0.00%
Castro::construct_old_source() 50 4.156e-05 7.02e-05 9.301e-05 0.00%
Castro::do_new_sources() 10 4.672e-05 7.028e-05 8.475e-05 0.00%
Castro::Castro() 1 5.406e-05 6.824e-05 8.132e-05 0.00%
Castro::do_old_sources() 10 4.4e-05 6.917e-05 8.058e-05 0.00%
Amr::FinalizeInit() 1 3.563e-06 1.355e-05 7.774e-05 0.00%
Castro::advance() 10 3.339e-05 4.712e-05 7.592e-05 0.00%
FillPatchSingleLevel 41 6.841e-05 7.242e-05 7.565e-05 0.00%
FabArrayBase::getCPC() 41 5.035e-05 5.871e-05 7.497e-05 0.00%
Amr::writeSmallPlotFile() 1 2.491e-05 5.649e-05 7.123e-05 0.00%
Castro::construct_old_gravity() 10 3.944e-05 5.396e-05 6.574e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.86e-05 4.852e-05 6.374e-05 0.00%
Castro::apply_source_to_state() 20 4.423e-05 5.181e-05 5.762e-05 0.00%
Castro::finalize_advance() 10 4.858e-05 5.247e-05 5.71e-05 0.00%
Castro::construct_new_gravity() 10 4.198e-05 4.83e-05 5.244e-05 0.00%
Amr::defBaseLevel() 1 3.011e-05 4.095e-05 4.71e-05 0.00%
Castro::post_timestep() 10 1.357e-05 2.008e-05 3.76e-05 0.00%
Castro::enforce_speed_limit() 62 2.569e-05 2.902e-05 3.302e-05 0.00%
FabArrayBase::CPC::define() 2 2.109e-05 2.637e-05 3.202e-05 0.00%
Castro::check_for_nan() 20 2.234e-05 2.523e-05 2.98e-05 0.00%
AmrLevel::AmrLevel(dm) 1 7.085e-06 1.134e-05 1.771e-05 0.00%
Gravity::swapTimeLevels() 10 6.968e-06 1.204e-05 1.515e-05 0.00%
Castro::create_source_corrector() 10 7.277e-06 1.075e-05 1.417e-05 0.00%
Amr::InitializeInit() 1 2.037e-06 3.895e-06 1.21e-05 0.00%
Gravity::set_mass_offset() 10 7.302e-06 9.428e-06 1.117e-05 0.00%
Castro::FluxRegCrseInit 10 6.014e-06 8.467e-06 1.093e-05 0.00%
Castro::computeNewDt() 9 8.381e-06 9.242e-06 1.059e-05 0.00%
Amr::initSubcycle() 1 8.038e-06 8.465e-06 9.555e-06 0.00%
Castro::retry_advance_ctu() 10 3.439e-06 5.936e-06 7.386e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.524e-06 4.234e-06 5.498e-06 0.00%
Castro::post_regrid() 1 2.329e-06 3.327e-06 4.508e-06 0.00%
DistributionMapping::Distribute() 1 9.2e-07 1.475e-06 4.477e-06 0.00%
Castro::computeInitialDt() 2 3.021e-06 3.655e-06 4.435e-06 0.00%
Castro::post_init() 1 2.925e-06 3.459e-06 3.714e-06 0.00%
Castro::FluxRegFineAdd() 10 1.81e-06 2.453e-06 3.027e-06 0.00%
Amr::init() 1 1.44e-06 1.863e-06 2.672e-06 0.00%
Amr::initialInit() 1 1.318e-06 1.512e-06 1.829e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.69 3.693 3.693 100.00%
Amr::coarseTimeStep() 10 3.485 3.485 3.485 94.37%
Amr::timeStep() 10 3.473 3.474 3.475 94.10%
Castro::advance() 10 3.457 3.458 3.459 93.65%
Castro::subcycle_advance_ctu() 10 3.385 3.387 3.395 91.93%
Castro::do_advance_ctu() 10 3.385 3.387 3.395 91.92%
Castro::construct_ctu_hydro_source() 10 2.097 2.426 2.547 68.96%
Gravity::make_radial_gravity() 21 0.3414 0.3553 0.3837 10.39%
Gravity::get_new_grav_vector() 11 0.2294 0.2345 0.2362 6.40%
Castro::construct_old_gravity() 10 0.1984 0.211 0.2325 6.30%
Gravity::get_old_grav_vector() 10 0.1975 0.2102 0.232 6.28%
FillPatchIterator::Initialize 41 0.188 0.198 0.2172 5.88%
Castro::construct_new_gravity() 10 0.2021 0.2063 0.2079 5.63%
Amr::init() 1 0.1899 0.19 0.19 5.15%
Castro::initialize_do_advance() 10 0.168 0.1804 0.1889 5.11%
FillPatchSingleLevel 41 0.1367 0.1517 0.1877 5.08%
Amr::initialInit() 1 0.1732 0.1734 0.1737 4.70%
FabArray::ParallelCopy() 41 0.09166 0.1096 0.1532 4.15%
Amr::InitializeInit() 1 0.06059 0.1003 0.1421 3.85%
Amr::defBaseLevel() 1 0.06059 0.1003 0.1421 3.85%
Castro::expand_state() 10 0.1251 0.1328 0.1396 3.78%
FabArray::ParallelCopy_finish() 41 0.04241 0.06455 0.1252 3.39%
Castro::initData() 1 0.04367 0.08312 0.1233 3.34%
Castro::estTimeStep() 21 0.02902 0.07255 0.1217 3.30%
Castro::clean_state() 62 0.1089 0.1165 0.1197 3.24%
Amr::FinalizeInit() 1 0.03131 0.07313 0.1128 3.05%
Castro::computeInitialDt() 2 0.001615 0.04342 0.08312 2.25%
Castro::initialize_advance() 10 0.0625 0.07123 0.07347 1.99%
Castro::computeTemp() 63 0.0629 0.06888 0.0719 1.95%
FabArray::setVal() 143 0.06176 0.06985 0.07186 1.95%
Castro::do_new_sources() 10 0.05343 0.06304 0.06507 1.76%
Castro::reset_internal_energy(MultiFab) 63 0.0458 0.05 0.05223 1.41%
Castro::reset_internal_energy(Fab) 1008 0.0455 0.0497 0.05194 1.41%
FabArray::ParallelCopy_nowait() 41 0.02792 0.04494 0.04988 1.35%
Castro::do_old_sources() 10 0.03265 0.04527 0.04922 1.33%
StateDataPhysBCFunct::() 41 0.03444 0.04201 0.04636 1.26%
StateData::FillBoundary(geom) 41 0.03432 0.04188 0.04622 1.25%
Castro::normalize_species() 62 0.04066 0.04162 0.0429 1.16%
Castro::construct_new_source() 50 0.02495 0.02941 0.03048 0.83%
Castro::post_init() 1 0.02872 0.02898 0.02933 0.79%
Gravity::interpolate_monopole_grav() 21 0.02639 0.02746 0.02791 0.76%
Amr::writePlotFile() 2 0.02666 0.02701 0.02726 0.74%
Castro::construct_new_gravity_source() 10 0.02024 0.02293 0.02379 0.64%
VisMF::Write(FabArray) 2 0.01313 0.01389 0.01828 0.49%
Castro::post_timestep() 10 0.01557 0.01591 0.01623 0.44%
Castro::apply_source_to_state() 20 0.008674 0.01432 0.01594 0.43%
MultiFab::Saxpy() 20 0.00863 0.01426 0.01588 0.43%
FabArray::setDomainBndry() 41 0.004847 0.01051 0.0124 0.34%
Castro::check_for_nan() 20 0.009511 0.01108 0.01226 0.33%
MultiFab::contains_nan() 20 0.009488 0.01105 0.01223 0.33%
Castro::Castro() 1 0.01114 0.0113 0.01223 0.33%
Castro::construct_old_source() 50 0.005013 0.01019 0.01179 0.32%
Castro::construct_old_gravity_source() 10 0.004972 0.01012 0.01171 0.32%
Castro::initMFs() 1 0.006608 0.00689 0.008717 0.24%
Castro::computeNewDt() 9 0.008142 0.008148 0.008158 0.22%
Castro::enforce_min_density() 62 0.006103 0.006718 0.007221 0.20%
AmrLevel::AmrLevel(dm) 1 0.005561 0.005667 0.006333 0.17%
StateData::define() 4 0.005552 0.005656 0.006319 0.17%
Castro::swap_state_time_levels() 10 0.002582 0.004304 0.004585 0.12%
Castro::buildMetrics() 1 0.001692 0.001752 0.002015 0.05%
Castro::finalize_do_advance() 10 0.0006578 0.001437 0.001758 0.05%
Castro::post_regrid() 1 0.001571 0.001635 0.001687 0.05%
Amr::InitAmr() 1 0.0002685 0.0003013 0.0004127 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.131e-05 0.0001342 0.0001649 0.00%
DistributionMapping::LeastUsedCPUs() 1 6.79e-06 0.0001285 0.0001575 0.00%
Castro::enforce_consistent_e() 1 7.783e-05 8.803e-05 0.0001068 0.00%
FabArrayBase::getCPC() 41 7.482e-05 8.507e-05 0.0001041 0.00%
Amr::writeSmallPlotFile() 1 2.491e-05 5.649e-05 7.123e-05 0.00%
Castro::finalize_advance() 10 5.794e-05 6.339e-05 7.096e-05 0.00%
Castro::enforce_speed_limit() 62 2.569e-05 2.902e-05 3.302e-05 0.00%
FabArrayBase::CPC::define() 2 2.109e-05 2.637e-05 3.202e-05 0.00%
Gravity::swapTimeLevels() 10 6.968e-06 1.204e-05 1.515e-05 0.00%
Castro::create_source_corrector() 10 7.277e-06 1.075e-05 1.417e-05 0.00%
Gravity::set_mass_offset() 10 7.302e-06 9.428e-06 1.117e-05 0.00%
Castro::FluxRegCrseInit 10 6.014e-06 8.467e-06 1.093e-05 0.00%
Amr::initSubcycle() 1 8.038e-06 8.465e-06 9.555e-06 0.00%
Castro::retry_advance_ctu() 10 3.439e-06 5.936e-06 7.386e-06 0.00%
DistributionMapping::Distribute() 1 9.2e-07 1.475e-06 4.477e-06 0.00%
Castro::FluxRegFineAdd() 10 1.81e-06 2.453e-06 3.027e-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.09-9-g67384701a808) finalized