MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.05-4-gef52970b80e3) initialized
Starting run at 16:38:17 UTC on 2022-05-04.
Successfully read inputs file ...
Castro git describe: 22.05-27-gbfc27bda5
AMReX git describe: 22.05-4-gef52970b8
Microphysics git describe: 22.05
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.013424137 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.35385238
[STEP 1] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.339247408
[STEP 2] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.323993767
[STEP 3] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.323879318
[STEP 4] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.3212837
[STEP 5] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.343105797
[STEP 6] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.304674687
[STEP 7] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.301375503
[STEP 8] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.30257926
[STEP 9] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
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.30269207
[STEP 10] FAB kilobyte spread across MPI nodes: [57854 ... 57854]
STEP = 10 TIME = 0.000571255455 DT = 7.045732848e-05
PLOTFILE: file = dustcollapse-3d-monopole_plt00010
Write plotfile time = 0.009552867 seconds
Ending run at 16:38:20 UTC on 2022-05-04.
Run time = 3.404677989
Run time without initialization = 3.229664415
Average number of zones advanced per microsecond: 0.812
Average number of zones advanced per microsecond per rank: 0.101
TinyProfiler total time across processes [min...avg...max]: 3.404 ... 3.405 ... 3.405
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.2266 2.2779 2.3096 67.84%
Gravity::make_radial_gravity() 21 0.3432 0.3538 0.3697 10.86%
Castro::do_advance_ctu() 10 0.05036 0.08199 0.1313 3.86%
Castro::initData() 1 0.03821 0.08311 0.1137 3.34%
Castro::estTimeStep() 21 0.01956 0.05274 0.1051 3.09%
FabArray::ParallelCopy_finish() 41 0.0313 0.04267 0.09136 2.68%
FabArray::setVal() 143 0.05228 0.06598 0.07172 2.11%
Castro::reset_internal_energy(Fab) 1008 0.04878 0.04983 0.05118 1.50%
StateData::FillBoundary(geom) 41 0.03794 0.04164 0.04477 1.31%
Castro::normalize_species() 62 0.04121 0.04209 0.04314 1.27%
FabArray::ParallelCopy_nowait() 41 0.03402 0.03994 0.04165 1.22%
FillPatchIterator::Initialize 41 0.02381 0.03159 0.03472 1.02%
Gravity::interpolate_monopole_grav() 21 0.02766 0.02801 0.02848 0.84%
Castro::construct_new_gravity_source() 10 0.0203 0.02348 0.02654 0.78%
Castro::expand_state() 10 0.01199 0.01788 0.02035 0.60%
Castro::computeTemp() 63 0.01781 0.0186 0.01963 0.58%
Castro::initialize_do_advance() 10 0.01028 0.01607 0.01814 0.53%
MultiFab::Saxpy() 20 0.01277 0.01476 0.0158 0.46%
VisMF::Write(FabArray) 2 0.01121 0.01235 0.01494 0.44%
Castro::initialize_advance() 10 0.003798 0.01016 0.01336 0.39%
Gravity::get_new_grav_vector() 11 0.009219 0.01099 0.01334 0.39%
Amr::writePlotFile() 2 0.008261 0.01093 0.01205 0.35%
MultiFab::contains_nan() 20 0.01012 0.01094 0.01185 0.35%
Castro::construct_old_gravity_source() 10 0.007293 0.01106 0.0118 0.35%
FabArray::setDomainBndry() 41 0.006375 0.009829 0.01177 0.35%
Gravity::get_old_grav_vector() 10 0.006852 0.008904 0.01022 0.30%
Castro::initMFs() 1 0.005334 0.006321 0.008638 0.25%
Castro::enforce_min_density() 62 0.006305 0.006708 0.007118 0.21%
Castro::construct_new_source() 50 0.005717 0.006332 0.006724 0.20%
StateData::define() 4 0.004387 0.005007 0.006524 0.19%
Castro::swap_state_time_levels() 10 0.002588 0.003615 0.004276 0.13%
main() 1 0.003587 0.003822 0.003999 0.12%
Castro::buildMetrics() 1 0.001248 0.001437 0.00188 0.06%
Castro::finalize_do_advance() 10 0.0004605 0.0008977 0.00107 0.03%
Amr::coarseTimeStep() 10 0.0003633 0.0006068 0.0009331 0.03%
Amr::InitAmr() 1 0.0002708 0.0003394 0.0006063 0.02%
Amr::timeStep() 10 0.0001716 0.0002246 0.0004482 0.01%
DistributionMapping::LeastUsedCPUs() 1 9.658e-06 0.0003108 0.0003882 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002846 0.0002899 0.0003009 0.01%
Castro::clean_state() 62 0.0001393 0.0001511 0.0001618 0.00%
StateDataPhysBCFunct::() 41 0.0001093 0.00014 0.0001577 0.00%
Castro::enforce_consistent_e() 1 7.595e-05 9.102e-05 0.0001002 0.00%
Castro::construct_old_source() 50 4.616e-05 6.763e-05 8.083e-05 0.00%
Castro::Castro() 1 4.929e-05 5.852e-05 7.859e-05 0.00%
Amr::FinalizeInit() 1 3.967e-06 1.341e-05 7.212e-05 0.00%
Castro::do_old_sources() 10 4.672e-05 5.772e-05 7.197e-05 0.00%
Castro::subcycle_advance_ctu() 10 4.047e-05 5.606e-05 7.181e-05 0.00%
FillPatchSingleLevel 41 5.981e-05 6.66e-05 7.142e-05 0.00%
Castro::do_new_sources() 10 4.726e-05 5.961e-05 6.826e-05 0.00%
Amr::writeSmallPlotFile() 1 2.536e-05 5.284e-05 6.185e-05 0.00%
FabArray::ParallelCopy() 41 4.938e-05 5.627e-05 6.004e-05 0.00%
Castro::advance() 10 3.275e-05 4.062e-05 5.758e-05 0.00%
FabArrayBase::getCPC() 41 4.063e-05 4.832e-05 5.717e-05 0.00%
Castro::finalize_advance() 10 4.843e-05 5.297e-05 5.708e-05 0.00%
Castro::construct_old_gravity() 10 3.758e-05 4.641e-05 5.163e-05 0.00%
Castro::apply_source_to_state() 20 3.447e-05 4.251e-05 4.804e-05 0.00%
Amr::defBaseLevel() 1 2.446e-05 3.206e-05 4.694e-05 0.00%
Castro::construct_new_gravity() 10 3.538e-05 3.925e-05 4.503e-05 0.00%
Castro::enforce_speed_limit() 62 2.692e-05 2.833e-05 3.073e-05 0.00%
Castro::check_for_nan() 20 2.038e-05 2.464e-05 2.694e-05 0.00%
FabArrayBase::CPC::define() 2 2.404e-05 2.563e-05 2.674e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.432e-05 1.721e-05 2.116e-05 0.00%
Amr::initSubcycle() 1 8.268e-06 1.056e-05 1.617e-05 0.00%
Castro::post_init() 1 8.34e-06 1.088e-05 1.58e-05 0.00%
Gravity::swapTimeLevels() 10 8.741e-06 1.196e-05 1.406e-05 0.00%
Castro::FluxRegCrseInit 10 7.159e-06 9.715e-06 1.201e-05 0.00%
Castro::post_timestep() 10 8.894e-06 1.066e-05 1.165e-05 0.00%
Castro::create_source_corrector() 10 8.133e-06 9.564e-06 1.131e-05 0.00%
Gravity::set_mass_offset() 10 8.044e-06 9.925e-06 1.127e-05 0.00%
Castro::computeNewDt() 9 7.247e-06 8.74e-06 9.815e-06 0.00%
Amr::InitializeInit() 1 1.948e-06 3.205e-06 8.842e-06 0.00%
Castro::post_regrid() 1 2.05e-06 4.007e-06 8.007e-06 0.00%
Castro::computeInitialDt() 2 3.025e-06 4.624e-06 6.62e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.685e-06 4.7e-06 6.523e-06 0.00%
Castro::retry_advance_ctu() 10 5.065e-06 5.735e-06 6.351e-06 0.00%
Castro::FluxRegFineAdd() 10 2.241e-06 2.513e-06 2.751e-06 0.00%
Amr::init() 1 1.877e-06 2.205e-06 2.535e-06 0.00%
Amr::initialInit() 1 1.312e-06 1.599e-06 1.971e-06 0.00%
DistributionMapping::Distribute() 1 1.004e-06 1.234e-06 1.544e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.404 3.405 3.405 100.00%
Amr::coarseTimeStep() 10 3.216 3.216 3.216 94.46%
Amr::timeStep() 10 3.207 3.207 3.207 94.21%
Castro::advance() 10 3.191 3.191 3.191 93.73%
Castro::subcycle_advance_ctu() 10 3.118 3.122 3.141 92.24%
Castro::do_advance_ctu() 10 3.117 3.122 3.14 92.24%
Castro::construct_ctu_hydro_source() 10 2.227 2.278 2.31 67.84%
Gravity::make_radial_gravity() 21 0.3432 0.3538 0.3697 10.86%
Gravity::get_new_grav_vector() 11 0.2272 0.2282 0.2294 6.74%
Castro::construct_old_gravity() 10 0.2016 0.2104 0.2234 6.56%
Gravity::get_old_grav_vector() 10 0.2009 0.2096 0.2227 6.54%
Castro::construct_new_gravity() 10 0.2017 0.2023 0.203 5.96%
FillPatchIterator::Initialize 41 0.1565 0.166 0.1965 5.77%
Amr::init() 1 0.1742 0.1745 0.1746 5.13%
FillPatchSingleLevel 41 0.1148 0.1246 0.1664 4.89%
Castro::initialize_do_advance() 10 0.1472 0.1559 0.165 4.85%
Amr::initialInit() 1 0.1605 0.1609 0.1613 4.74%
Amr::InitializeInit() 1 0.05591 0.1024 0.1316 3.87%
Amr::defBaseLevel() 1 0.0559 0.1024 0.1316 3.87%
Castro::expand_state() 10 0.1011 0.1092 0.126 3.70%
FabArray::ParallelCopy() 41 0.07227 0.08274 0.1255 3.69%
Castro::clean_state() 62 0.1147 0.1167 0.1198 3.52%
Castro::initData() 1 0.04215 0.08711 0.1178 3.46%
Castro::estTimeStep() 21 0.01956 0.05274 0.1051 3.09%
Amr::FinalizeInit() 1 0.02937 0.05848 0.1051 3.09%
FabArray::ParallelCopy_finish() 41 0.0313 0.04267 0.09136 2.68%
Castro::computeInitialDt() 2 0.001696 0.03082 0.07739 2.27%
Castro::initialize_advance() 10 0.04996 0.0686 0.07354 2.16%
FabArray::setVal() 143 0.05228 0.06598 0.07172 2.11%
Castro::computeTemp() 63 0.06729 0.06872 0.0711 2.09%
Castro::do_new_sources() 10 0.05744 0.06243 0.0673 1.98%
Castro::reset_internal_energy(MultiFab) 63 0.04908 0.05012 0.05147 1.51%
Castro::reset_internal_energy(Fab) 1008 0.04878 0.04983 0.05118 1.50%
Castro::do_old_sources() 10 0.04057 0.04697 0.04835 1.42%
StateDataPhysBCFunct::() 41 0.03805 0.04178 0.04492 1.32%
StateData::FillBoundary(geom) 41 0.03794 0.04164 0.04477 1.31%
Castro::normalize_species() 62 0.04121 0.04209 0.04314 1.27%
FabArray::ParallelCopy_nowait() 41 0.0341 0.04001 0.04173 1.23%
Castro::construct_new_source() 50 0.02601 0.02981 0.033 0.97%
Gravity::interpolate_monopole_grav() 21 0.02766 0.02801 0.02848 0.84%
Castro::post_init() 1 0.02667 0.02689 0.02704 0.79%
Castro::construct_new_gravity_source() 10 0.0203 0.02348 0.02654 0.78%
Amr::writePlotFile() 2 0.02294 0.02328 0.02355 0.69%
Castro::post_timestep() 10 0.01544 0.01578 0.01604 0.47%
Castro::apply_source_to_state() 20 0.01282 0.0148 0.01585 0.47%
MultiFab::Saxpy() 20 0.01277 0.01476 0.0158 0.46%
VisMF::Write(FabArray) 2 0.01121 0.01235 0.01494 0.44%
Castro::Castro() 1 0.008918 0.009906 0.01236 0.36%
Castro::check_for_nan() 20 0.01014 0.01097 0.01188 0.35%
Castro::construct_old_source() 50 0.007339 0.01113 0.01188 0.35%
MultiFab::contains_nan() 20 0.01012 0.01094 0.01185 0.35%
Castro::construct_old_gravity_source() 10 0.007293 0.01106 0.0118 0.35%
FabArray::setDomainBndry() 41 0.006375 0.009829 0.01177 0.35%
Castro::initMFs() 1 0.005334 0.006321 0.008638 0.25%
Castro::computeNewDt() 9 0.006855 0.007652 0.008181 0.24%
Castro::enforce_min_density() 62 0.006305 0.006708 0.007118 0.21%
AmrLevel::AmrLevel(dm) 1 0.004404 0.005024 0.006543 0.19%
StateData::define() 4 0.004387 0.005007 0.006524 0.19%
Castro::swap_state_time_levels() 10 0.002588 0.003615 0.004276 0.13%
Castro::buildMetrics() 1 0.001366 0.001588 0.002109 0.06%
Castro::post_regrid() 1 0.001545 0.001674 0.001916 0.06%
Castro::finalize_do_advance() 10 0.0004605 0.0008977 0.00107 0.03%
Amr::InitAmr() 1 0.0002802 0.00035 0.0006215 0.02%
DistributionMapping::SFCProcessorMapDoIt() 1 1.554e-05 0.0003167 0.0003952 0.01%
DistributionMapping::LeastUsedCPUs() 1 9.658e-06 0.0003108 0.0003882 0.01%
Castro::enforce_consistent_e() 1 7.595e-05 9.102e-05 0.0001002 0.00%
FabArrayBase::getCPC() 41 6.601e-05 7.395e-05 8.387e-05 0.00%
Castro::finalize_advance() 10 6.149e-05 6.519e-05 6.876e-05 0.00%
Amr::writeSmallPlotFile() 1 2.536e-05 5.284e-05 6.185e-05 0.00%
Castro::enforce_speed_limit() 62 2.692e-05 2.833e-05 3.073e-05 0.00%
FabArrayBase::CPC::define() 2 2.404e-05 2.563e-05 2.674e-05 0.00%
Amr::initSubcycle() 1 8.268e-06 1.056e-05 1.617e-05 0.00%
Gravity::swapTimeLevels() 10 8.741e-06 1.196e-05 1.406e-05 0.00%
Castro::FluxRegCrseInit 10 7.159e-06 9.715e-06 1.201e-05 0.00%
Castro::create_source_corrector() 10 8.133e-06 9.564e-06 1.131e-05 0.00%
Gravity::set_mass_offset() 10 8.044e-06 9.925e-06 1.127e-05 0.00%
Castro::retry_advance_ctu() 10 5.065e-06 5.735e-06 6.351e-06 0.00%
Castro::FluxRegFineAdd() 10 2.241e-06 2.513e-06 2.751e-06 0.00%
DistributionMapping::Distribute() 1 1.004e-06 1.234e-06 1.544e-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.05-4-gef52970b80e3) finalized