MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.09-11-g9aa23c202a13) initialized
Starting run at 05:39:15 UTC on 2022-09-13.
Successfully read inputs file ...
Castro git describe: 22.09
AMReX git describe: 22.09-11-g9aa23c202
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.019219902 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.359704551
[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.344593285
[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.344018454
[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.347995073
[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.3513692
[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.347123973
[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.338568083
[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.339632138
[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.340172524
[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.339442982
[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.021075878 seconds
Ending run at 05:39:19 UTC on 2022-09-13.
Run time = 3.73257862
Run time without initialization = 3.481626348
Average number of zones advanced per microsecond: 0.753
Average number of zones advanced per microsecond per rank: 0.094
TinyProfiler total time across processes [min...avg...max]: 3.732 ... 3.732 ... 3.733
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.1119 2.4131 2.5252 67.65%
Castro::do_advance_ctu() 10 0.02847 0.1419 0.4465 11.96%
Gravity::make_radial_gravity() 21 0.3452 0.3661 0.3971 10.64%
Castro::initData() 1 0.04945 0.09983 0.1598 4.28%
Castro::estTimeStep() 21 0.03012 0.09235 0.157 4.21%
FabArray::ParallelCopy_finish() 41 0.03934 0.06412 0.1365 3.66%
FabArray::setVal() 143 0.05036 0.06561 0.07036 1.88%
Castro::reset_internal_energy(Fab) 1008 0.04614 0.05073 0.05361 1.44%
FabArray::ParallelCopy_nowait() 41 0.0277 0.04495 0.05148 1.38%
StateData::FillBoundary(geom) 41 0.03394 0.0427 0.04882 1.31%
Castro::normalize_species() 62 0.04043 0.04229 0.04378 1.17%
FillPatchIterator::Initialize 41 0.0244 0.03688 0.04263 1.14%
Gravity::interpolate_monopole_grav() 21 0.0262 0.02777 0.02866 0.77%
Amr::writePlotFile() 2 0.0197 0.02543 0.02778 0.74%
Castro::construct_new_gravity_source() 10 0.01975 0.02273 0.02345 0.63%
Castro::expand_state() 10 0.009884 0.01902 0.02314 0.62%
Castro::computeTemp() 63 0.01742 0.01915 0.02103 0.56%
Castro::initialize_do_advance() 10 0.01031 0.01825 0.02094 0.56%
VisMF::Write(FabArray) 2 0.01297 0.01467 0.02084 0.56%
MultiFab::Saxpy() 20 0.008816 0.01438 0.01663 0.45%
Gravity::get_new_grav_vector() 11 0.007537 0.0116 0.01358 0.36%
MultiFab::contains_nan() 20 0.009768 0.01106 0.01254 0.34%
FabArray::setDomainBndry() 41 0.004877 0.01038 0.01247 0.33%
Castro::construct_old_gravity_source() 10 0.004946 0.01001 0.01195 0.32%
Gravity::get_old_grav_vector() 10 0.005533 0.009593 0.01113 0.30%
Castro::initialize_advance() 10 0.00329 0.00891 0.01085 0.29%
Castro::initMFs() 1 0.006669 0.008553 0.009939 0.27%
StateData::define() 4 0.005524 0.007024 0.008165 0.22%
Castro::enforce_min_density() 62 0.006023 0.006795 0.007332 0.20%
main() 1 0.00645 0.00682 0.007227 0.19%
Castro::construct_new_source() 50 0.004811 0.006593 0.007211 0.19%
Castro::swap_state_time_levels() 10 0.002618 0.005239 0.006514 0.17%
Amr::coarseTimeStep() 10 0.000966 0.001531 0.002526 0.07%
Castro::buildMetrics() 1 0.001582 0.002013 0.002357 0.06%
Castro::finalize_do_advance() 10 0.0006597 0.001581 0.0019 0.05%
Amr::InitAmr() 1 0.0002775 0.0004107 0.0005049 0.01%
Amr::timeStep() 10 0.0001799 0.0002266 0.0003768 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002804 0.0003008 0.0003191 0.01%
DistributionMapping::LeastUsedCPUs() 1 6.242e-06 0.0001282 0.0002859 0.01%
Castro::clean_state() 62 0.0001521 0.0001657 0.0001944 0.01%
Castro::enforce_consistent_e() 1 9.344e-05 0.0001145 0.000151 0.00%
StateDataPhysBCFunct::() 41 0.0001038 0.0001162 0.0001266 0.00%
FabArray::ParallelCopy() 41 7.836e-05 9.192e-05 0.0001022 0.00%
Castro::construct_old_source() 50 3.783e-05 7.358e-05 9.279e-05 0.00%
Castro::do_old_sources() 10 3.898e-05 7.15e-05 8.866e-05 0.00%
Castro::advance() 10 3.079e-05 4.833e-05 8.743e-05 0.00%
FillPatchSingleLevel 41 6.24e-05 7.145e-05 8.609e-05 0.00%
Castro::do_new_sources() 10 4.432e-05 7.196e-05 8.511e-05 0.00%
Amr::FinalizeInit() 1 3.7e-06 1.477e-05 8.386e-05 0.00%
Castro::Castro() 1 5.696e-05 6.857e-05 8.267e-05 0.00%
FabArrayBase::getCPC() 41 5.038e-05 5.651e-05 7.185e-05 0.00%
Amr::writeSmallPlotFile() 1 2.313e-05 4.848e-05 6.937e-05 0.00%
Castro::construct_old_gravity() 10 3.453e-05 5.49e-05 6.674e-05 0.00%
Castro::apply_source_to_state() 20 3.911e-05 5.428e-05 6.649e-05 0.00%
Amr::defBaseLevel() 1 3.791e-05 4.944e-05 6.242e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.357e-05 4.663e-05 5.821e-05 0.00%
Castro::finalize_advance() 10 4.71e-05 5.218e-05 5.535e-05 0.00%
Castro::construct_new_gravity() 10 3.63e-05 4.471e-05 4.872e-05 0.00%
Castro::enforce_speed_limit() 62 2.44e-05 2.815e-05 3.704e-05 0.00%
FabArrayBase::CPC::define() 2 2.35e-05 2.837e-05 3.399e-05 0.00%
AmrLevel::AmrLevel(dm) 1 7.052e-06 1.705e-05 2.704e-05 0.00%
Castro::check_for_nan() 20 2.113e-05 2.371e-05 2.614e-05 0.00%
Gravity::swapTimeLevels() 10 5.246e-06 1.429e-05 1.965e-05 0.00%
Castro::post_timestep() 10 1.274e-05 1.464e-05 1.741e-05 0.00%
Amr::initSubcycle() 1 8.283e-06 1.161e-05 1.478e-05 0.00%
Castro::create_source_corrector() 10 6.341e-06 1.052e-05 1.266e-05 0.00%
Castro::computeNewDt() 9 8.261e-06 9.429e-06 1.086e-05 0.00%
Gravity::set_mass_offset() 10 6.202e-06 8.473e-06 1.006e-05 0.00%
Castro::FluxRegCrseInit 10 5.071e-06 8.023e-06 9.825e-06 0.00%
Castro::retry_advance_ctu() 10 4.131e-06 6.408e-06 8.129e-06 0.00%
Castro::post_regrid() 1 2.129e-06 3.51e-06 6.896e-06 0.00%
Amr::InitializeInit() 1 2.23e-06 4.099e-06 6.836e-06 0.00%
Castro::computeInitialDt() 2 3.523e-06 4.18e-06 6.082e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.947e-06 4.376e-06 5.008e-06 0.00%
Castro::post_init() 1 3.395e-06 3.968e-06 4.869e-06 0.00%
Amr::init() 1 1.927e-06 2.394e-06 3.308e-06 0.00%
Castro::FluxRegFineAdd() 10 2.35e-06 2.599e-06 3.171e-06 0.00%
Amr::initialInit() 1 1.249e-06 1.663e-06 2.188e-06 0.00%
DistributionMapping::Distribute() 1 9.79e-07 1.249e-06 1.488e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.732 3.732 3.733 100.00%
Amr::coarseTimeStep() 10 3.453 3.453 3.453 92.52%
Amr::timeStep() 10 3.442 3.443 3.444 92.27%
Castro::advance() 10 3.426 3.427 3.428 91.83%
Castro::subcycle_advance_ctu() 10 3.352 3.358 3.376 90.44%
Castro::do_advance_ctu() 10 3.352 3.358 3.376 90.44%
Castro::construct_ctu_hydro_source() 10 2.112 2.413 2.525 67.65%
Gravity::make_radial_gravity() 21 0.3452 0.3661 0.3971 10.64%
Amr::init() 1 0.2503 0.2504 0.2505 6.71%
Gravity::get_new_grav_vector() 11 0.2409 0.2432 0.245 6.56%
Castro::construct_old_gravity() 10 0.1986 0.2158 0.2395 6.42%
Gravity::get_old_grav_vector() 10 0.1977 0.2151 0.239 6.40%
Amr::initialInit() 1 0.231 0.2314 0.232 6.21%
FillPatchIterator::Initialize 41 0.1865 0.1994 0.2278 6.10%
Castro::construct_new_gravity() 10 0.2019 0.2036 0.205 5.49%
FillPatchSingleLevel 41 0.1345 0.1521 0.1985 5.32%
Castro::initialize_do_advance() 10 0.165 0.1812 0.1905 5.10%
Amr::InitializeInit() 1 0.07119 0.1241 0.1876 5.03%
Amr::defBaseLevel() 1 0.07118 0.1241 0.1876 5.03%
Castro::initData() 1 0.05363 0.1044 0.1651 4.42%
FabArray::ParallelCopy() 41 0.09067 0.1092 0.1644 4.40%
Amr::FinalizeInit() 1 0.04437 0.1074 0.1598 4.28%
Castro::estTimeStep() 21 0.03012 0.09235 0.157 4.21%
Castro::expand_state() 10 0.1205 0.1324 0.138 3.70%
FabArray::ParallelCopy_finish() 41 0.03934 0.06412 0.1365 3.66%
Castro::clean_state() 62 0.1094 0.1182 0.1238 3.32%
Castro::computeInitialDt() 2 0.002412 0.06604 0.1189 3.19%
Castro::initialize_advance() 10 0.05051 0.0691 0.07544 2.02%
Castro::computeTemp() 63 0.06387 0.07019 0.07452 2.00%
FabArray::setVal() 143 0.05036 0.06561 0.07036 1.88%
Castro::do_new_sources() 10 0.05312 0.06309 0.06497 1.74%
Castro::reset_internal_energy(MultiFab) 63 0.04645 0.05103 0.05393 1.44%
Castro::reset_internal_energy(Fab) 1008 0.04614 0.05073 0.05361 1.44%
FabArray::ParallelCopy_nowait() 41 0.02781 0.04504 0.05157 1.38%
Castro::do_old_sources() 10 0.03191 0.04495 0.04908 1.31%
StateDataPhysBCFunct::() 41 0.03404 0.04281 0.04895 1.31%
StateData::FillBoundary(geom) 41 0.03394 0.0427 0.04882 1.31%
Castro::normalize_species() 62 0.04043 0.04229 0.04378 1.17%
Amr::writePlotFile() 2 0.03946 0.0401 0.04075 1.09%
Castro::post_init() 1 0.04011 0.04034 0.04059 1.09%
Castro::construct_new_source() 50 0.02456 0.02932 0.03057 0.82%
Gravity::interpolate_monopole_grav() 21 0.0262 0.02777 0.02866 0.77%
Castro::construct_new_gravity_source() 10 0.01975 0.02273 0.02345 0.63%
VisMF::Write(FabArray) 2 0.01297 0.01467 0.02084 0.56%
Castro::apply_source_to_state() 20 0.008855 0.01443 0.01669 0.45%
MultiFab::Saxpy() 20 0.008816 0.01438 0.01663 0.45%
Castro::post_timestep() 10 0.01555 0.01594 0.01643 0.44%
Castro::Castro() 1 0.009726 0.01243 0.01461 0.39%
Castro::check_for_nan() 20 0.009789 0.01109 0.01256 0.34%
MultiFab::contains_nan() 20 0.009768 0.01106 0.01254 0.34%
FabArray::setDomainBndry() 41 0.004877 0.01038 0.01247 0.33%
Castro::construct_old_source() 50 0.004984 0.01009 0.01205 0.32%
Castro::construct_old_gravity_source() 10 0.004946 0.01001 0.01195 0.32%
Castro::initMFs() 1 0.006669 0.008553 0.009939 0.27%
AmrLevel::AmrLevel(dm) 1 0.005531 0.007041 0.008179 0.22%
StateData::define() 4 0.005524 0.007024 0.008165 0.22%
Castro::enforce_min_density() 62 0.006023 0.006795 0.007332 0.20%
Castro::computeNewDt() 9 0.007055 0.007062 0.007071 0.19%
Castro::swap_state_time_levels() 10 0.002618 0.005239 0.006514 0.17%
Castro::post_regrid() 1 0.001512 0.002288 0.002942 0.08%
Castro::buildMetrics() 1 0.001692 0.002179 0.002577 0.07%
Castro::finalize_do_advance() 10 0.0006597 0.001581 0.0019 0.05%
Amr::InitAmr() 1 0.0002866 0.0004224 0.0005197 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.145e-05 0.0001338 0.0002924 0.01%
DistributionMapping::LeastUsedCPUs() 1 6.242e-06 0.0001282 0.0002859 0.01%
Castro::enforce_consistent_e() 1 9.344e-05 0.0001145 0.000151 0.00%
FabArrayBase::getCPC() 41 7.971e-05 8.488e-05 0.0001058 0.00%
Amr::writeSmallPlotFile() 1 2.313e-05 4.848e-05 6.937e-05 0.00%
Castro::finalize_advance() 10 5.469e-05 6.28e-05 6.769e-05 0.00%
Castro::enforce_speed_limit() 62 2.44e-05 2.815e-05 3.704e-05 0.00%
FabArrayBase::CPC::define() 2 2.35e-05 2.837e-05 3.399e-05 0.00%
Gravity::swapTimeLevels() 10 5.246e-06 1.429e-05 1.965e-05 0.00%
Amr::initSubcycle() 1 8.283e-06 1.161e-05 1.478e-05 0.00%
Castro::create_source_corrector() 10 6.341e-06 1.052e-05 1.266e-05 0.00%
Gravity::set_mass_offset() 10 6.202e-06 8.473e-06 1.006e-05 0.00%
Castro::FluxRegCrseInit 10 5.071e-06 8.023e-06 9.825e-06 0.00%
Castro::retry_advance_ctu() 10 4.131e-06 6.408e-06 8.129e-06 0.00%
Castro::FluxRegFineAdd() 10 2.35e-06 2.599e-06 3.171e-06 0.00%
DistributionMapping::Distribute() 1 9.79e-07 1.249e-06 1.488e-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-11-g9aa23c202a13) finalized