MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.04-38-g3d344ec19655) initialized
Starting run at 05:37:26 UTC on 2022-04-29.
Successfully read inputs file ...
Castro git describe: 22.04-44-gef991073e
AMReX git describe: 22.04-38-g3d344ec19
Microphysics git describe: 22.04-3-g3c498521
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.014238309 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.356008936
[STEP 1] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.342620777
[STEP 2] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.32047839
[STEP 3] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.315682119
[STEP 4] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.320303154
[STEP 5] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.34101662
[STEP 6] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.309624297
[STEP 7] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.303536139
[STEP 8] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.299760099
[STEP 9] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
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.304056302
[STEP 10] FAB kilobyte spread across MPI nodes: [58394 ... 58394]
STEP = 10 TIME = 0.000571255455 DT = 7.045732848e-05
PLOTFILE: file = dustcollapse-3d-monopole_plt00010
Write plotfile time = 0.009674332 seconds
Ending run at 05:37:30 UTC on 2022-04-29.
Run time = 3.424594259
Run time without initialization = 3.226113069
Average number of zones advanced per microsecond: 0.813
Average number of zones advanced per microsecond per rank: 0.102
TinyProfiler total time across processes [min...avg...max]: 3.424 ... 3.424 ... 3.425
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.1992 2.2546 2.2887 66.83%
Gravity::make_radial_gravity() 21 0.3365 0.3466 0.3618 10.56%
Castro::do_advance_ctu() 10 0.07156 0.1059 0.1602 4.68%
Castro::initData() 1 0.03984 0.08034 0.1344 3.93%
Castro::estTimeStep() 21 0.02497 0.07787 0.1172 3.42%
FabArray::setVal() 143 0.06938 0.07421 0.07878 2.30%
FabArray::ParallelCopy_finish() 41 0.03446 0.04006 0.06093 1.78%
Castro::reset_internal_energy(Fab) 1008 0.04722 0.04949 0.05153 1.50%
Castro::normalize_species() 62 0.04186 0.04231 0.0428 1.25%
StateData::FillBoundary(geom) 41 0.03815 0.04092 0.0424 1.24%
FabArray::ParallelCopy_nowait() 41 0.03348 0.03955 0.04121 1.20%
FillPatchIterator::Initialize 41 0.02459 0.02936 0.03255 0.95%
Gravity::interpolate_monopole_grav() 21 0.02805 0.02838 0.02882 0.84%
Castro::construct_new_gravity_source() 10 0.02029 0.0236 0.02659 0.78%
Castro::expand_state() 10 0.01231 0.01802 0.021 0.61%
Castro::computeTemp() 63 0.01733 0.0183 0.01891 0.55%
Castro::initialize_do_advance() 10 0.01128 0.01602 0.01744 0.51%
MultiFab::Saxpy() 20 0.01311 0.01477 0.01571 0.46%
VisMF::Write(FabArray) 2 0.01152 0.01275 0.0154 0.45%
Castro::initialize_advance() 10 0.01065 0.01271 0.01487 0.43%
MultiFab::contains_nan() 20 0.01045 0.01144 0.01266 0.37%
Gravity::get_new_grav_vector() 11 0.009548 0.01072 0.01265 0.37%
Amr::writePlotFile() 2 0.008757 0.01125 0.01239 0.36%
Castro::construct_old_gravity_source() 10 0.007285 0.0109 0.01185 0.35%
FabArray::setDomainBndry() 41 0.007066 0.009276 0.01066 0.31%
Gravity::get_old_grav_vector() 10 0.007179 0.008712 0.009975 0.29%
Castro::enforce_min_density() 62 0.006525 0.006882 0.007259 0.21%
Castro::construct_new_source() 50 0.00571 0.00648 0.006874 0.20%
Castro::initMFs() 1 0.005369 0.0057 0.00659 0.19%
StateData::define() 4 0.004328 0.004484 0.004804 0.14%
main() 1 0.003838 0.003986 0.004201 0.12%
Castro::swap_state_time_levels() 10 0.002763 0.003657 0.004115 0.12%
Castro::buildMetrics() 1 0.001223 0.001269 0.001364 0.04%
Amr::coarseTimeStep() 10 0.0002963 0.000656 0.001262 0.04%
Castro::finalize_do_advance() 10 0.0004663 0.0009625 0.001153 0.03%
Amr::timeStep() 10 0.000166 0.0002285 0.0004377 0.01%
Amr::InitAmr() 1 0.0002521 0.0002904 0.0003698 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002914 0.0003036 0.0003231 0.01%
Castro::clean_state() 62 0.0001452 0.0001579 0.0001684 0.00%
StateDataPhysBCFunct::() 41 9.762e-05 0.0001201 0.0001309 0.00%
Castro::enforce_consistent_e() 1 7.711e-05 8.917e-05 0.0001005 0.00%
Castro::construct_old_source() 50 5.559e-05 7.236e-05 9.182e-05 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.369e-06 6.877e-05 9.152e-05 0.00%
Amr::FinalizeInit() 1 4.184e-06 1.525e-05 8.821e-05 0.00%
Castro::Castro() 1 5.203e-05 6.857e-05 8.152e-05 0.00%
Castro::do_new_sources() 10 4.928e-05 6.112e-05 7.482e-05 0.00%
FabArray::ParallelCopy() 41 5.937e-05 6.571e-05 7.459e-05 0.00%
Castro::do_old_sources() 10 4.985e-05 6.258e-05 7.421e-05 0.00%
FillPatchSingleLevel 41 5.671e-05 6.448e-05 7.102e-05 0.00%
Amr::writeSmallPlotFile() 1 2.49e-05 5.075e-05 6.852e-05 0.00%
Castro::advance() 10 3.61e-05 4.379e-05 6.676e-05 0.00%
Castro::construct_old_gravity() 10 3.858e-05 4.895e-05 5.889e-05 0.00%
Castro::finalize_advance() 10 4.933e-05 5.189e-05 5.709e-05 0.00%
FabArrayBase::getCPC() 41 4.136e-05 4.96e-05 5.621e-05 0.00%
Castro::subcycle_advance_ctu() 10 4.088e-05 4.893e-05 5.598e-05 0.00%
Castro::apply_source_to_state() 20 3.66e-05 4.652e-05 5.289e-05 0.00%
Castro::construct_new_gravity() 10 3.567e-05 4.136e-05 4.759e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.675e-05 2.346e-05 3.701e-05 0.00%
Amr::defBaseLevel() 1 2.13e-05 2.913e-05 3.577e-05 0.00%
Castro::enforce_speed_limit() 62 2.569e-05 2.928e-05 3.423e-05 0.00%
FabArrayBase::CPC::define() 2 2.261e-05 2.695e-05 2.895e-05 0.00%
Castro::check_for_nan() 20 2.004e-05 2.106e-05 2.275e-05 0.00%
Castro::post_init() 1 8.558e-06 1.099e-05 1.706e-05 0.00%
Gravity::swapTimeLevels() 10 9.16e-06 1.36e-05 1.673e-05 0.00%
Castro::create_source_corrector() 10 8.186e-06 1.079e-05 1.18e-05 0.00%
Castro::post_timestep() 10 8.841e-06 9.99e-06 1.139e-05 0.00%
Gravity::set_mass_offset() 10 7.465e-06 9.627e-06 1.127e-05 0.00%
Castro::FluxRegCrseInit 10 7.95e-06 9.109e-06 1.115e-05 0.00%
Castro::computeNewDt() 9 7.88e-06 8.707e-06 9.907e-06 0.00%
Amr::initSubcycle() 1 8.272e-06 8.915e-06 9.76e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.692e-06 5.003e-06 6.746e-06 0.00%
Castro::retry_advance_ctu() 10 5.086e-06 5.614e-06 6.327e-06 0.00%
Amr::InitializeInit() 1 2.091e-06 2.693e-06 5.925e-06 0.00%
Castro::post_regrid() 1 2.274e-06 3.819e-06 5.349e-06 0.00%
Castro::computeInitialDt() 2 3.606e-06 4.397e-06 5.112e-06 0.00%
Castro::FluxRegFineAdd() 10 2.273e-06 2.794e-06 3.777e-06 0.00%
Amr::init() 1 1.692e-06 2.002e-06 2.554e-06 0.00%
Amr::initialInit() 1 1.343e-06 1.669e-06 2.134e-06 0.00%
DistributionMapping::Distribute() 1 9.02e-07 1.1e-06 1.294e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.424 3.424 3.425 100.00%
Amr::coarseTimeStep() 10 3.212 3.212 3.212 93.80%
Amr::timeStep() 10 3.203 3.203 3.204 93.56%
Castro::advance() 10 3.187 3.187 3.188 93.08%
Castro::subcycle_advance_ctu() 10 3.107 3.11 3.112 90.87%
Castro::do_advance_ctu() 10 3.107 3.11 3.112 90.87%
Castro::construct_ctu_hydro_source() 10 2.199 2.255 2.289 66.83%
Gravity::make_radial_gravity() 21 0.3365 0.3466 0.3618 10.56%
Gravity::get_new_grav_vector() 11 0.2224 0.2243 0.2254 6.58%
Castro::construct_old_gravity() 10 0.1992 0.2067 0.2191 6.40%
Gravity::get_old_grav_vector() 10 0.1984 0.206 0.2184 6.38%
Castro::construct_new_gravity() 10 0.1969 0.1979 0.1985 5.80%
Amr::init() 1 0.198 0.198 0.198 5.78%
Amr::initialInit() 1 0.1835 0.1838 0.184 5.37%
FillPatchIterator::Initialize 41 0.1522 0.1595 0.1681 4.91%
Castro::initialize_do_advance() 10 0.1427 0.1517 0.1575 4.60%
Amr::InitializeInit() 1 0.05768 0.09876 0.1538 4.49%
Amr::defBaseLevel() 1 0.05768 0.09875 0.1538 4.49%
Castro::initData() 1 0.04396 0.08445 0.1385 4.04%
FillPatchSingleLevel 41 0.117 0.1209 0.1365 3.99%
Amr::FinalizeInit() 1 0.03016 0.08501 0.1259 3.68%
Castro::clean_state() 62 0.1129 0.1165 0.1199 3.50%
Castro::estTimeStep() 21 0.02497 0.07787 0.1172 3.42%
Castro::expand_state() 10 0.09834 0.105 0.1086 3.17%
Castro::computeInitialDt() 2 0.001793 0.05689 0.0979 2.86%
FabArray::ParallelCopy() 41 0.07526 0.07975 0.09455 2.76%
Castro::initialize_advance() 10 0.07556 0.07772 0.08028 2.34%
FabArray::setVal() 143 0.06938 0.07421 0.07878 2.30%
Castro::computeTemp() 63 0.06486 0.06809 0.07061 2.06%
Castro::do_new_sources() 10 0.05727 0.06304 0.06841 2.00%
FabArray::ParallelCopy_finish() 41 0.03446 0.04006 0.06093 1.78%
Castro::reset_internal_energy(MultiFab) 63 0.04753 0.04979 0.05184 1.51%
Castro::reset_internal_energy(Fab) 1008 0.04722 0.04949 0.05153 1.50%
Castro::do_old_sources() 10 0.04121 0.04726 0.04901 1.43%
Castro::normalize_species() 62 0.04186 0.04231 0.0428 1.25%
StateDataPhysBCFunct::() 41 0.03827 0.04104 0.04252 1.24%
StateData::FillBoundary(geom) 41 0.03815 0.04092 0.0424 1.24%
FabArray::ParallelCopy_nowait() 41 0.03356 0.03963 0.04128 1.21%
Castro::construct_new_source() 50 0.026 0.03009 0.03347 0.98%
Gravity::interpolate_monopole_grav() 21 0.02805 0.02838 0.02882 0.84%
Castro::post_init() 1 0.02717 0.02743 0.02761 0.81%
Castro::construct_new_gravity_source() 10 0.02029 0.0236 0.02659 0.78%
Amr::writePlotFile() 2 0.02377 0.024 0.02416 0.71%
Castro::post_timestep() 10 0.01517 0.01579 0.01628 0.48%
Castro::apply_source_to_state() 20 0.01316 0.01482 0.01577 0.46%
MultiFab::Saxpy() 20 0.01311 0.01477 0.01571 0.46%
VisMF::Write(FabArray) 2 0.01152 0.01275 0.0154 0.45%
Castro::check_for_nan() 20 0.01047 0.01146 0.01268 0.37%
MultiFab::contains_nan() 20 0.01045 0.01144 0.01266 0.37%
Castro::construct_old_source() 50 0.007341 0.01097 0.01191 0.35%
Castro::construct_old_gravity_source() 10 0.007285 0.0109 0.01185 0.35%
FabArray::setDomainBndry() 41 0.007066 0.009276 0.01066 0.31%
Castro::Castro() 1 0.00932 0.009691 0.01048 0.31%
Castro::computeNewDt() 9 0.006656 0.007283 0.008007 0.23%
Castro::enforce_min_density() 62 0.006525 0.006882 0.007259 0.21%
Castro::initMFs() 1 0.005369 0.0057 0.00659 0.19%
AmrLevel::AmrLevel(dm) 1 0.004347 0.004508 0.004828 0.14%
StateData::define() 4 0.004328 0.004484 0.004804 0.14%
Castro::swap_state_time_levels() 10 0.002763 0.003657 0.004115 0.12%
Castro::post_regrid() 1 0.001568 0.001638 0.001865 0.05%
Castro::buildMetrics() 1 0.001341 0.001401 0.001519 0.04%
Castro::finalize_do_advance() 10 0.0004663 0.0009625 0.001153 0.03%
Amr::InitAmr() 1 0.0002604 0.0002993 0.0003783 0.01%
Castro::enforce_consistent_e() 1 7.711e-05 8.917e-05 0.0001005 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 1.219e-05 7.488e-05 9.912e-05 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.369e-06 6.877e-05 9.152e-05 0.00%
FabArrayBase::getCPC() 41 6.78e-05 7.655e-05 8.398e-05 0.00%
Castro::finalize_advance() 10 6.073e-05 6.379e-05 7.162e-05 0.00%
Amr::writeSmallPlotFile() 1 2.49e-05 5.075e-05 6.852e-05 0.00%
Castro::enforce_speed_limit() 62 2.569e-05 2.928e-05 3.423e-05 0.00%
FabArrayBase::CPC::define() 2 2.261e-05 2.695e-05 2.895e-05 0.00%
Gravity::swapTimeLevels() 10 9.16e-06 1.36e-05 1.673e-05 0.00%
Castro::create_source_corrector() 10 8.186e-06 1.079e-05 1.18e-05 0.00%
Gravity::set_mass_offset() 10 7.465e-06 9.627e-06 1.127e-05 0.00%
Castro::FluxRegCrseInit 10 7.95e-06 9.109e-06 1.115e-05 0.00%
Amr::initSubcycle() 1 8.272e-06 8.915e-06 9.76e-06 0.00%
Castro::retry_advance_ctu() 10 5.086e-06 5.614e-06 6.327e-06 0.00%
Castro::FluxRegFineAdd() 10 2.273e-06 2.794e-06 3.777e-06 0.00%
DistributionMapping::Distribute() 1 9.02e-07 1.1e-06 1.294e-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.04-38-g3d344ec19655) finalized