MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (23.09-24-gf08b40b34bd4) initialized
Starting run at 05:20:41 UTC on 2023-09-27.
Successfully read inputs file ...
Castro git describe: 23.09-34-g7561a65ab
AMReX git describe: 23.09-24-gf08b40b34
Microphysics git describe: 23.09-14-g9c08d809
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.013667545 seconds
[Level 0 step 1] ADVANCE at time 0 with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.356654362
[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 at time 4.541742215e-05 with dt = 4.768829326e-05
[Level 0 step 2] Advanced 262144 cells
[STEP 2] Coarse TimeStep time: 0.347096894
[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 at time 9.31057154e-05 with dt = 5.007270792e-05
[Level 0 step 3] Advanced 262144 cells
[STEP 3] Coarse TimeStep time: 0.332716451
[STEP 3] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 3 TIME = 0.0001431784233 DT = 5.007270792e-05
[Level 0 step 4] ADVANCE at time 0.0001431784233 with dt = 5.257634331e-05
[Level 0 step 4] Advanced 262144 cells
[STEP 4] Coarse TimeStep time: 0.3316599
[STEP 4] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 4 TIME = 0.0001957547666 DT = 5.257634331e-05
[Level 0 step 5] ADVANCE at time 0.0001957547666 with dt = 5.520516048e-05
[Level 0 step 5] Advanced 262144 cells
[STEP 5] Coarse TimeStep time: 0.338594999
[STEP 5] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 5 TIME = 0.0002509599271 DT = 5.520516048e-05
[Level 0 step 6] ADVANCE at time 0.0002509599271 with dt = 5.79654185e-05
[Level 0 step 6] Advanced 262144 cells
[STEP 6] Coarse TimeStep time: 0.362845306
[STEP 6] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 6 TIME = 0.0003089253456 DT = 5.79654185e-05
[Level 0 step 7] ADVANCE at time 0.0003089253456 with dt = 6.086368943e-05
[Level 0 step 7] Advanced 262144 cells
[STEP 7] Coarse TimeStep time: 0.320041374
[STEP 7] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 7 TIME = 0.000369789035 DT = 6.086368943e-05
[Level 0 step 8] ADVANCE at time 0.000369789035 with dt = 6.39068739e-05
[Level 0 step 8] Advanced 262144 cells
[STEP 8] Coarse TimeStep time: 0.317753225
[STEP 8] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 8 TIME = 0.000433695909 DT = 6.39068739e-05
[Level 0 step 9] ADVANCE at time 0.000433695909 with dt = 6.71022176e-05
[Level 0 step 9] Advanced 262144 cells
[STEP 9] Coarse TimeStep time: 0.314952289
[STEP 9] FAB kilobyte spread across MPI nodes: [57998 ... 57998]
STEP = 9 TIME = 0.0005007981265 DT = 6.71022176e-05
[Level 0 step 10] ADVANCE at time 0.0005007981265 with dt = 7.045732848e-05
[Level 0 step 10] Advanced 262144 cells
[STEP 10] Coarse TimeStep time: 0.315688474
[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.009912661 seconds
Ending run at 05:20:44 UTC on 2023-09-27.
Run time = 3.548424496
Run time without initialization = 3.352181223
Average number of zones advanced per microsecond: 0.782
Average number of zones advanced per microsecond per rank: 0.098
TinyProfiler total time across processes [min...avg...max]: 3.548 ... 3.548 ... 3.549
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.2830 2.3396 2.4007 67.65%
Gravity::make_radial_gravity() 21 0.3148 0.3337 0.3535 9.96%
check_for_negative_density() 10 0.03684 0.1011 0.1575 4.44%
Castro::initData() 1 0.03846 0.07941 0.133 3.75%
Castro::estTimeStep() 21 0.02394 0.08362 0.1286 3.63%
FabArray::ParallelCopy_finish() 41 0.04027 0.05116 0.09735 2.74%
amrex::Copy() 193 0.06319 0.07902 0.0936 2.64%
FabArray::setVal() 143 0.05409 0.06876 0.0752 2.12%
Castro::reset_internal_energy(Fab) 1008 0.04695 0.04862 0.05055 1.42%
Castro::normalize_species() 62 0.04044 0.04183 0.0435 1.23%
StateData::FillBoundary(geom) 41 0.03347 0.03753 0.04321 1.22%
FabArray::ParallelCopy_nowait() 41 0.03312 0.03998 0.04188 1.18%
FillPatchIterator::Initialize 41 0.02567 0.03087 0.03367 0.95%
Gravity::interpolate_monopole_grav() 21 0.02827 0.02854 0.02883 0.81%
Castro::construct_new_gravity_source() 10 0.02171 0.02387 0.02562 0.72%
Castro::computeTemp() 63 0.01881 0.01984 0.0206 0.58%
Castro::initialize_do_advance() 10 0.01091 0.01594 0.01753 0.49%
VisMF::Write(FabArray) 2 0.01179 0.01282 0.01531 0.43%
MultiFab::contains_nan() 20 0.01067 0.01231 0.01498 0.42%
Castro::initialize_advance() 10 0.003811 0.01078 0.01414 0.40%
FabArray::Saxpy() 20 0.01075 0.01261 0.01384 0.39%
FabArray::setDomainBndry() 41 0.008383 0.01092 0.01239 0.35%
Amr::writePlotFile() 2 0.005795 0.008514 0.0108 0.30%
Castro::construct_old_gravity_source() 10 0.006649 0.009385 0.01029 0.29%
Castro::initMFs() 1 0.006216 0.00657 0.008057 0.23%
Castro::enforce_min_density() 62 0.007135 0.007357 0.007696 0.22%
Castro::construct_new_source() 50 0.005873 0.006437 0.007003 0.20%
StateData::define() 4 0.005084 0.005189 0.005733 0.16%
Castro::swap_state_time_levels() 10 0.002949 0.003983 0.004332 0.12%
Amr::coarseTimeStep() 10 0.002201 0.003224 0.004033 0.11%
Gravity::get_new_grav_vector() 11 0.002663 0.003409 0.003851 0.11%
main() 1 0.003338 0.003463 0.003578 0.10%
Gravity::get_old_grav_vector() 10 0.001507 0.001875 0.002239 0.06%
Castro::buildMetrics() 1 0.001429 0.00148 0.001674 0.05%
Castro::finalize_do_advance() 10 0.0003881 0.00104 0.001315 0.04%
AmrLevel::FillPatch() 41 0.0006139 0.0008004 0.0009213 0.03%
Amr::InitAmr() 1 0.0002696 0.0002935 0.0004091 0.01%
Amr::timeStep() 10 0.0002074 0.000252 0.0003472 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002747 0.0002931 0.0003353 0.01%
Castro::do_advance_ctu() 10 0.0001501 0.000182 0.0002144 0.01%
StateDataPhysBCFunct::() 41 8.724e-05 0.0001347 0.0001741 0.00%
Castro::clean_state() 62 0.0001374 0.0001509 0.0001662 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.332e-06 0.0001226 0.0001429 0.00%
Castro::finalize_advance() 10 8.537e-05 0.0001018 0.0001254 0.00%
FillPatchIterator::FillFromLevel0() 41 9.771e-05 0.0001094 0.0001229 0.00%
Amr::FinalizeInit() 1 3.987e-06 1.916e-05 0.0001133 0.00%
Castro::do_old_sources() 10 6.35e-05 8.976e-05 0.0001064 0.00%
FabArray::ParallelCopy() 41 6.228e-05 8.45e-05 9.654e-05 0.00%
Castro::enforce_consistent_e() 1 7.576e-05 8.487e-05 9.313e-05 0.00%
Castro::Castro() 1 5.855e-05 7.72e-05 9.227e-05 0.00%
Castro::construct_old_source() 50 5.019e-05 6.646e-05 8.712e-05 0.00%
FillPatchSingleLevel 41 5.512e-05 6.846e-05 7.463e-05 0.00%
FabArrayBase::getCPC() 41 4.266e-05 5.388e-05 7.032e-05 0.00%
Castro::advance() 10 3.48e-05 4.825e-05 6.91e-05 0.00%
Castro::do_new_sources() 10 4.887e-05 6.234e-05 6.781e-05 0.00%
Amr::writeSmallPlotFile() 1 2.776e-05 5.343e-05 6.527e-05 0.00%
Castro::subcycle_advance_ctu() 10 4.099e-05 4.831e-05 5.687e-05 0.00%
Castro::apply_source_to_state() 20 3.412e-05 4.629e-05 5.226e-05 0.00%
Castro::construct_old_gravity() 10 4.014e-05 4.739e-05 5.223e-05 0.00%
Castro::construct_new_gravity() 10 3.451e-05 4.179e-05 4.776e-05 0.00%
Amr::defBaseLevel() 1 2.522e-05 3.049e-05 4.103e-05 0.00%
Castro::enforce_speed_limit() 62 2.427e-05 2.935e-05 3.442e-05 0.00%
Castro::expand_state() 10 2.018e-05 2.566e-05 3.154e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.443e-05 2.079e-05 3.07e-05 0.00%
FabArrayBase::CPC::define() 2 2.207e-05 2.466e-05 2.965e-05 0.00%
Castro::check_for_nan() 20 2.238e-05 2.536e-05 2.751e-05 0.00%
Gravity::set_mass_offset() 10 9.163e-06 1.193e-05 1.836e-05 0.00%
Gravity::swapTimeLevels() 10 1.123e-05 1.436e-05 1.826e-05 0.00%
Castro::post_timestep() 10 1.325e-05 1.563e-05 1.769e-05 0.00%
Castro::computeNewDt() 9 9.594e-06 1.199e-05 1.51e-05 0.00%
Castro::create_source_corrector() 10 6.253e-06 8.54e-06 1.075e-05 0.00%
Amr::initSubcycle() 1 8.612e-06 9.117e-06 1.012e-05 0.00%
Castro::FluxRegCrseInit 10 6.176e-06 7.763e-06 9.015e-06 0.00%
Castro::retry_advance_ctu() 10 6.872e-06 7.841e-06 8.709e-06 0.00%
Amr::init() 1 2.249e-06 3.342e-06 8.539e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.566e-06 5.595e-06 6.936e-06 0.00%
Castro::post_regrid() 1 2.078e-06 3.941e-06 6.071e-06 0.00%
Castro::computeInitialDt() 2 3.788e-06 4.925e-06 5.968e-06 0.00%
Amr::InitializeInit() 1 1.76e-06 2.419e-06 5.137e-06 0.00%
Castro::post_init() 1 3.033e-06 3.884e-06 4.522e-06 0.00%
Castro::FluxRegFineAdd() 10 2.155e-06 2.483e-06 3.145e-06 0.00%
Amr::initialInit() 1 1.442e-06 1.737e-06 2.008e-06 0.00%
DistributionMapping::Distribute() 1 9.63e-07 1.215e-06 1.435e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.548 3.548 3.548 100.00%
Amr::coarseTimeStep() 10 3.339 3.339 3.339 94.09%
Amr::timeStep() 10 3.324 3.325 3.326 93.72%
Castro::advance() 10 3.308 3.308 3.308 93.23%
Castro::subcycle_advance_ctu() 10 3.229 3.234 3.253 91.68%
Castro::do_advance_ctu() 10 3.229 3.234 3.253 91.68%
Castro::construct_ctu_hydro_source() 10 2.458 2.462 2.465 69.46%
Gravity::make_radial_gravity() 21 0.3316 0.3498 0.3667 10.33%
Gravity::get_new_grav_vector() 11 0.2229 0.224 0.2253 6.35%
Castro::construct_old_gravity() 10 0.1945 0.2099 0.2242 6.32%
Gravity::get_old_grav_vector() 10 0.1935 0.2091 0.2236 6.30%
AmrLevel::FillPatch() 41 0.1859 0.203 0.2217 6.25%
Castro::construct_new_gravity() 10 0.1993 0.1999 0.2008 5.66%
FillPatchIterator::Initialize 41 0.153 0.1709 0.1984 5.59%
Amr::init() 1 0.1957 0.1958 0.1958 5.52%
Amr::initialInit() 1 0.1815 0.1819 0.1821 5.13%
Castro::initialize_do_advance() 10 0.1571 0.1687 0.1797 5.06%
FillPatchIterator::FillFromLevel0() 41 0.1165 0.1291 0.1644 4.63%
FillPatchSingleLevel 41 0.1164 0.129 0.1643 4.63%
check_for_negative_density() 10 0.03684 0.1011 0.1575 4.44%
Amr::InitializeInit() 1 0.05829 0.09957 0.1542 4.35%
Amr::defBaseLevel() 1 0.05829 0.09957 0.1542 4.35%
Castro::initData() 1 0.04256 0.0834 0.1367 3.85%
FabArray::ParallelCopy() 41 0.08215 0.0913 0.1306 3.68%
Castro::estTimeStep() 21 0.02394 0.08362 0.1286 3.63%
Castro::expand_state() 10 0.1037 0.1147 0.1265 3.57%
Amr::FinalizeInit() 1 0.02765 0.08231 0.1237 3.49%
Castro::clean_state() 62 0.1136 0.1172 0.1202 3.39%
Castro::do_old_sources() 10 0.09319 0.09606 0.09921 2.80%
Castro::computeInitialDt() 2 0.002171 0.05683 0.09813 2.77%
FabArray::ParallelCopy_finish() 41 0.04027 0.05116 0.09735 2.74%
amrex::Copy() 193 0.06319 0.07902 0.0936 2.64%
Castro::initialize_advance() 10 0.05088 0.07047 0.0755 2.13%
FabArray::setVal() 143 0.05409 0.06876 0.0752 2.12%
Castro::computeTemp() 63 0.06604 0.06875 0.07133 2.01%
Castro::do_new_sources() 10 0.06018 0.06357 0.06853 1.93%
Castro::reset_internal_energy(MultiFab) 63 0.04723 0.04891 0.05085 1.43%
Castro::reset_internal_energy(Fab) 1008 0.04695 0.04862 0.05055 1.42%
Castro::normalize_species() 62 0.04044 0.04183 0.0435 1.23%
StateDataPhysBCFunct::() 41 0.03356 0.03767 0.04335 1.22%
StateData::FillBoundary(geom) 41 0.03347 0.03753 0.04321 1.22%
FabArray::ParallelCopy_nowait() 41 0.03321 0.04006 0.04195 1.18%
Castro::construct_new_source() 50 0.02759 0.0303 0.03263 0.92%
Gravity::interpolate_monopole_grav() 21 0.02827 0.02854 0.02883 0.81%
Castro::construct_new_gravity_source() 10 0.02171 0.02387 0.02562 0.72%
Castro::post_init() 1 0.02469 0.025 0.02528 0.71%
Amr::writePlotFile() 2 0.02375 0.02395 0.02432 0.69%
Castro::finalize_do_advance() 10 0.01292 0.018 0.02235 0.63%
Castro::post_timestep() 10 0.01536 0.01611 0.01695 0.48%
VisMF::Write(FabArray) 2 0.01179 0.01282 0.01531 0.43%
Castro::check_for_nan() 20 0.0107 0.01233 0.01501 0.42%
MultiFab::contains_nan() 20 0.01067 0.01231 0.01498 0.42%
Castro::apply_source_to_state() 20 0.0108 0.01266 0.01389 0.39%
FabArray::Saxpy() 20 0.01075 0.01261 0.01384 0.39%
FabArray::setDomainBndry() 41 0.008383 0.01092 0.01239 0.35%
Castro::Castro() 1 0.01042 0.0108 0.01166 0.33%
Castro::construct_old_source() 50 0.006699 0.009451 0.01036 0.29%
Castro::construct_old_gravity_source() 10 0.006649 0.009385 0.01029 0.29%
Castro::computeNewDt() 9 0.009829 0.009842 0.009857 0.28%
Castro::initMFs() 1 0.006216 0.00657 0.008057 0.23%
Castro::enforce_min_density() 62 0.007135 0.007357 0.007696 0.22%
AmrLevel::AmrLevel(dm) 1 0.005103 0.00521 0.005755 0.16%
StateData::define() 4 0.005084 0.005189 0.005733 0.16%
Castro::swap_state_time_levels() 10 0.002949 0.003983 0.004332 0.12%
Castro::finalize_advance() 10 0.003123 0.003384 0.003699 0.10%
Castro::buildMetrics() 1 0.001562 0.001619 0.001838 0.05%
Castro::post_regrid() 1 0.001535 0.001605 0.001683 0.05%
Amr::InitAmr() 1 0.0002786 0.0003026 0.0004179 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.189e-05 0.0001294 0.0001508 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.332e-06 0.0001226 0.0001429 0.00%
FabArrayBase::getCPC() 41 6.641e-05 7.854e-05 9.317e-05 0.00%
Castro::enforce_consistent_e() 1 7.576e-05 8.487e-05 9.313e-05 0.00%
Amr::writeSmallPlotFile() 1 2.776e-05 5.343e-05 6.527e-05 0.00%
Castro::enforce_speed_limit() 62 2.427e-05 2.935e-05 3.442e-05 0.00%
FabArrayBase::CPC::define() 2 2.207e-05 2.466e-05 2.965e-05 0.00%
Gravity::set_mass_offset() 10 9.163e-06 1.193e-05 1.836e-05 0.00%
Gravity::swapTimeLevels() 10 1.123e-05 1.436e-05 1.826e-05 0.00%
Castro::create_source_corrector() 10 6.253e-06 8.54e-06 1.075e-05 0.00%
Amr::initSubcycle() 1 8.612e-06 9.117e-06 1.012e-05 0.00%
Castro::FluxRegCrseInit 10 6.176e-06 7.763e-06 9.015e-06 0.00%
Castro::retry_advance_ctu() 10 6.872e-06 7.841e-06 8.709e-06 0.00%
Castro::FluxRegFineAdd() 10 2.155e-06 2.483e-06 3.145e-06 0.00%
DistributionMapping::Distribute() 1 9.63e-07 1.215e-06 1.435e-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]
Pinned Memory Usage:
---------------------------------------------------------------------------------------------------------------------
Name Nalloc Nfree AvgMem min AvgMem avg AvgMem max MaxMem min MaxMem avg MaxMem max
---------------------------------------------------------------------------------------------------------------------
The_Pinned_Arena::Initialize() 8 8 28 B 31 B 37 B 8192 KiB 8192 KiB 8192 KiB
---------------------------------------------------------------------------------------------------------------------
AMReX (23.09-24-gf08b40b34bd4) finalized