MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.01-39-g874ccc6f3f8d) initialized
Starting run at 06:31:17 UTC on 2022-01-25.
Successfully read inputs file ...
Castro git describe: 21.12-27-g958e0cc7a
AMReX git describe: 22.01-39-g874ccc6f3
Microphysics git describe: 22.01-20-g1a290c72
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.014109886 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.355118623
[STEP 1] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.324712398
[STEP 2] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.316925589
[STEP 3] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.316004059
[STEP 4] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.314563853
[STEP 5] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.341298614
[STEP 6] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.298348194
[STEP 7] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.292025089
[STEP 8] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.292050962
[STEP 9] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
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.293408296
[STEP 10] FAB kilobyte spread across MPI nodes: [58480 ... 58480]
STEP = 10 TIME = 0.000571255455 DT = 7.045732848e-05
PLOTFILE: file = dustcollapse-3d-monopole_plt00010
Write plotfile time = 0.041459655 seconds
Ending run at 06:31:21 UTC on 2022-01-25.
Run time = 3.373597971
Run time without initialization = 3.189730608
Average number of zones advanced per microsecond: 0.822
Average number of zones advanced per microsecond per rank: 0.103
TinyProfiler total time across processes [min...avg...max]: 3.373 ... 3.373 ... 3.374
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.1293 2.1776 2.2284 66.05%
Gravity::make_radial_gravity() 21 0.3596 0.3715 0.3813 11.30%
MultiFab::min() 10 0.017 0.07385 0.1274 3.78%
Castro::initData() 1 0.03836 0.07955 0.1119 3.32%
Castro::estTimeStep() 21 0.01741 0.0552 0.09508 2.82%
FabArray::setVal() 139 0.07113 0.07467 0.07865 2.33%
FabArray::ParallelCopy_finish() 41 0.03501 0.04081 0.05316 1.58%
Castro::reset_internal_energy() 63 0.04787 0.04981 0.05235 1.55%
StateData::FillBoundary(geom) 41 0.0409 0.0425 0.04663 1.38%
Amr::writePlotFile() 2 0.04096 0.04466 0.04533 1.34%
FabArray::ParallelCopy_nowait() 41 0.04029 0.04177 0.04329 1.28%
Castro::normalize_species() 62 0.03214 0.03333 0.03585 1.06%
FillPatchIterator::Initialize 41 0.0249 0.03177 0.03487 1.03%
Gravity::interpolate_monopole_grav() 21 0.02773 0.02835 0.02889 0.86%
Castro::construct_new_gravity_source() 10 0.02283 0.02474 0.02663 0.79%
Castro::do_advance_ctu() 10 0.01702 0.02026 0.02413 0.72%
Castro::expand_state() 10 0.01261 0.01829 0.02109 0.63%
Castro::computeTemp() 63 0.01714 0.01866 0.01995 0.59%
Castro::initialize_do_advance() 10 0.01164 0.01634 0.0178 0.53%
MultiFab::Saxpy() 20 0.01503 0.016 0.01714 0.51%
VisMF::Write(FabArray) 2 0.01151 0.0121 0.0149 0.44%
Castro::initialize_advance() 10 0.01056 0.01257 0.01485 0.44%
Gravity::get_new_grav_vector() 11 0.01008 0.0111 0.01293 0.38%
MultiFab::contains_nan() 20 0.01067 0.01154 0.01277 0.38%
Castro::construct_old_gravity_source() 10 0.009241 0.01165 0.01239 0.37%
FabArray::setDomainBndry() 41 0.006873 0.01035 0.01154 0.34%
Gravity::get_old_grav_vector() 10 0.007912 0.00916 0.01029 0.31%
Amr::defBaseLevel() 1 0.006849 0.006937 0.007176 0.21%
Castro::construct_new_source() 50 0.006486 0.006771 0.007067 0.21%
Castro::enforce_min_density() 62 0.005896 0.006155 0.006401 0.19%
StateData::define() 4 0.004288 0.004362 0.004486 0.13%
main() 1 0.003489 0.003782 0.003997 0.12%
Castro::swap_state_time_levels() 10 0.003338 0.003808 0.003897 0.12%
Amr::coarseTimeStep() 10 0.0002973 0.0006493 0.001529 0.05%
Castro::finalize_do_advance() 10 0.0007277 0.0008956 0.001005 0.03%
Amr::timeStep() 10 0.0001687 0.0002269 0.0004632 0.01%
Amr::InitAmr() 1 0.0002911 0.0003024 0.0003612 0.01%
Castro::clean_state() 62 0.0001272 0.0001408 0.0001559 0.00%
Castro::enforce_consistent_e() 1 8.657e-05 9.927e-05 0.0001304 0.00%
StateDataPhysBCFunct::() 41 9.568e-05 0.0001113 0.000125 0.00%
Amr::FinalizeInit() 1 3.451e-06 1.676e-05 0.0001001 0.00%
Castro::construct_old_source() 50 5.442e-05 7.576e-05 8.856e-05 0.00%
Castro::do_old_sources() 10 5.093e-05 6.35e-05 8.023e-05 0.00%
FillPatchSingleLevel 41 6.047e-05 6.854e-05 7.93e-05 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.362e-06 6.254e-05 7.092e-05 0.00%
FabArray::ParallelCopy() 41 5.664e-05 6.403e-05 7.003e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.624e-05 4.953e-05 6.95e-05 0.00%
Castro::do_new_sources() 10 4.959e-05 5.792e-05 6.674e-05 0.00%
Amr::writeSmallPlotFile() 1 2.617e-05 4.84e-05 6.448e-05 0.00%
Castro::apply_source_to_state() 20 3.818e-05 4.665e-05 6.212e-05 0.00%
Castro::advance() 10 3.085e-05 4.089e-05 6.182e-05 0.00%
Castro::finalize_advance() 10 5.122e-05 5.401e-05 5.639e-05 0.00%
FabArrayBase::getCPC() 41 3.943e-05 4.771e-05 5.63e-05 0.00%
Castro::construct_new_gravity() 10 3.845e-05 4.44e-05 5.353e-05 0.00%
Castro::construct_old_gravity() 10 4.336e-05 4.782e-05 5.062e-05 0.00%
FabArrayBase::CPC::define() 2 2.327e-05 3.005e-05 3.884e-05 0.00%
Castro::check_for_nan() 20 2.366e-05 2.6e-05 3.066e-05 0.00%
Castro::enforce_speed_limit() 62 2.515e-05 2.679e-05 2.869e-05 0.00%
Castro::create_source_corrector() 10 1.508e-05 1.722e-05 2.013e-05 0.00%
Gravity::swapTimeLevels() 10 1.165e-05 1.462e-05 1.865e-05 0.00%
AmrLevel::AmrLevel(dm) 1 6.51e-06 9.201e-06 1.393e-05 0.00%
Castro::post_timestep() 10 7.598e-06 9.319e-06 1.022e-05 0.00%
Castro::computeNewDt() 9 6.834e-06 8.263e-06 1.006e-05 0.00%
Amr::initSubcycle() 1 8.399e-06 8.812e-06 9.43e-06 0.00%
Gravity::set_mass_offset() 10 7.428e-06 8.215e-06 9.402e-06 0.00%
Castro::post_init() 1 2.936e-06 4.881e-06 8.892e-06 0.00%
Castro::retry_advance_ctu() 10 5.097e-06 5.842e-06 6.763e-06 0.00%
Castro::FluxRegFineAdd() 10 5.302e-06 5.935e-06 6.639e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.42e-06 5.388e-06 6.203e-06 0.00%
Amr::InitializeInit() 1 1.933e-06 2.888e-06 5.819e-06 0.00%
Castro::post_regrid() 1 1.918e-06 3.973e-06 5.741e-06 0.00%
Castro::computeInitialDt() 2 3.181e-06 4.249e-06 5.199e-06 0.00%
Amr::init() 1 2.058e-06 2.358e-06 2.736e-06 0.00%
Amr::initialInit() 1 1.405e-06 1.72e-06 2.215e-06 0.00%
DistributionMapping::Distribute() 1 9.33e-07 1.235e-06 1.354e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.373 3.373 3.374 100.00%
Amr::coarseTimeStep() 10 3.144 3.144 3.144 93.20%
Amr::timeStep() 10 3.135 3.135 3.136 92.95%
Castro::advance() 10 3.12 3.121 3.121 92.50%
Castro::subcycle_advance_ctu() 10 3.042 3.045 3.047 90.33%
Castro::do_advance_ctu() 10 3.042 3.045 3.047 90.33%
Castro::construct_ctu_hydro_source() 10 2.129 2.178 2.228 66.05%
Gravity::make_radial_gravity() 21 0.3596 0.3715 0.3813 11.30%
Gravity::get_new_grav_vector() 11 0.2375 0.2392 0.2405 7.13%
Castro::construct_old_gravity() 10 0.2101 0.219 0.227 6.73%
Gravity::get_old_grav_vector() 10 0.2093 0.2182 0.2262 6.70%
Castro::construct_new_gravity() 10 0.204 0.2046 0.205 6.08%
Amr::init() 1 0.1833 0.1834 0.1834 5.44%
FillPatchIterator::Initialize 41 0.1627 0.1675 0.1736 5.15%
Amr::initialInit() 1 0.1678 0.1682 0.169 5.01%
Castro::initialize_do_advance() 10 0.1445 0.1541 0.1597 4.73%
FillPatchSingleLevel 41 0.1187 0.1254 0.1352 4.01%
Amr::InitializeInit() 1 0.05673 0.09811 0.1301 3.86%
Amr::defBaseLevel() 1 0.05673 0.09811 0.1301 3.86%
MultiFab::min() 10 0.017 0.07385 0.1274 3.78%
Castro::initData() 1 0.04232 0.08378 0.1159 3.44%
Castro::expand_state() 10 0.1006 0.1091 0.1142 3.39%
Amr::FinalizeInit() 1 0.03807 0.07005 0.1112 3.30%
Castro::clean_state() 62 0.1034 0.1071 0.111 3.29%
Castro::estTimeStep() 21 0.01741 0.0552 0.09508 2.82%
FabArray::ParallelCopy() 41 0.07763 0.08272 0.09361 2.77%
FabArray::setVal() 139 0.07113 0.07467 0.07865 2.33%
Castro::initialize_advance() 10 0.07314 0.07532 0.07839 2.32%
Castro::computeInitialDt() 2 0.001884 0.03389 0.07528 2.23%
Castro::computeTemp() 63 0.06523 0.06847 0.0721 2.14%
Castro::do_new_sources() 10 0.06002 0.06397 0.06842 2.03%
Amr::writePlotFile() 2 0.05585 0.05676 0.05713 1.69%
FabArray::ParallelCopy_finish() 41 0.03501 0.04081 0.05316 1.58%
Castro::reset_internal_energy() 63 0.04787 0.04981 0.05235 1.55%
Castro::do_old_sources() 10 0.04544 0.04782 0.05006 1.48%
StateDataPhysBCFunct::() 41 0.04102 0.04262 0.04673 1.39%
StateData::FillBoundary(geom) 41 0.0409 0.0425 0.04663 1.38%
FabArray::ParallelCopy_nowait() 41 0.04039 0.04185 0.04336 1.29%
Castro::post_init() 1 0.03551 0.03575 0.03619 1.07%
Castro::normalize_species() 62 0.03214 0.03333 0.03585 1.06%
Castro::construct_new_source() 50 0.02941 0.03151 0.0336 1.00%
Gravity::interpolate_monopole_grav() 21 0.02773 0.02835 0.02889 0.86%
Castro::construct_new_gravity_source() 10 0.02283 0.02474 0.02663 0.79%
Castro::apply_source_to_state() 20 0.01507 0.01605 0.0172 0.51%
MultiFab::Saxpy() 20 0.01503 0.016 0.01714 0.51%
VisMF::Write(FabArray) 2 0.01151 0.0121 0.0149 0.44%
Castro::post_timestep() 10 0.01367 0.01413 0.01487 0.44%
Castro::check_for_nan() 20 0.01069 0.01157 0.01279 0.38%
MultiFab::contains_nan() 20 0.01067 0.01154 0.01277 0.38%
Castro::construct_old_source() 50 0.009295 0.01172 0.01247 0.37%
Castro::construct_old_gravity_source() 10 0.009241 0.01165 0.01239 0.37%
FabArray::setDomainBndry() 41 0.006873 0.01035 0.01154 0.34%
Castro::computeNewDt() 9 0.006836 0.00757 0.008152 0.24%
Castro::enforce_min_density() 62 0.005896 0.006155 0.006401 0.19%
AmrLevel::AmrLevel(dm) 1 0.004296 0.004371 0.004498 0.13%
StateData::define() 4 0.004288 0.004362 0.004486 0.13%
Castro::swap_state_time_levels() 10 0.003338 0.003808 0.003897 0.12%
Castro::post_regrid() 1 0.001368 0.001582 0.002623 0.08%
Castro::finalize_do_advance() 10 0.0007277 0.0008956 0.001005 0.03%
Amr::InitAmr() 1 0.0003002 0.0003112 0.0003698 0.01%
Castro::enforce_consistent_e() 1 8.657e-05 9.927e-05 0.0001304 0.00%
FabArrayBase::getCPC() 41 7.025e-05 7.777e-05 9.514e-05 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 1.192e-05 6.917e-05 7.802e-05 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.362e-06 6.254e-05 7.092e-05 0.00%
Amr::writeSmallPlotFile() 1 2.617e-05 4.84e-05 6.448e-05 0.00%
Castro::finalize_advance() 10 5.676e-05 5.995e-05 6.19e-05 0.00%
FabArrayBase::CPC::define() 2 2.327e-05 3.005e-05 3.884e-05 0.00%
Castro::enforce_speed_limit() 62 2.515e-05 2.679e-05 2.869e-05 0.00%
Castro::create_source_corrector() 10 1.508e-05 1.722e-05 2.013e-05 0.00%
Gravity::swapTimeLevels() 10 1.165e-05 1.462e-05 1.865e-05 0.00%
Amr::initSubcycle() 1 8.399e-06 8.812e-06 9.43e-06 0.00%
Gravity::set_mass_offset() 10 7.428e-06 8.215e-06 9.402e-06 0.00%
Castro::retry_advance_ctu() 10 5.097e-06 5.842e-06 6.763e-06 0.00%
Castro::FluxRegFineAdd() 10 5.302e-06 5.935e-06 6.639e-06 0.00%
DistributionMapping::Distribute() 1 9.33e-07 1.235e-06 1.354e-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.01-39-g874ccc6f3f8d) finalized