MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.05-24-g994073b931f1) initialized
Starting run at 05:38:18 UTC on 2022-05-19.
Successfully read inputs file ...
Castro git describe: 22.05-24-g1b7bd38a3
AMReX git describe: 22.05-24-g994073b93
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.013376296 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.344760513
[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.334313617
[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.335562469
[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.337261282
[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.346304166
[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.343929014
[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.332668577
[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.332582571
[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.332776338
[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.334871203
[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.00964273 seconds
Ending run at 05:38:22 UTC on 2022-05-19.
Run time = 3.611926
Run time without initialization = 3.390105677
Average number of zones advanced per microsecond: 0.773
Average number of zones advanced per microsecond per rank: 0.097
TinyProfiler total time across processes [min...avg...max]: 3.612 ... 3.612 ... 3.612
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.0462 2.3539 2.4567 68.01%
Castro::do_advance_ctu() 10 0.03326 0.1371 0.4477 12.40%
Gravity::make_radial_gravity() 21 0.338 0.3514 0.3791 10.50%
Castro::estTimeStep() 21 0.02998 0.09388 0.1631 4.52%
Castro::initData() 1 0.03984 0.09469 0.1546 4.28%
FabArray::ParallelCopy_finish() 41 0.03906 0.05887 0.1241 3.43%
FabArray::setVal() 143 0.0549 0.06718 0.07026 1.95%
Castro::reset_internal_energy(Fab) 1008 0.04728 0.05011 0.05149 1.43%
FabArray::ParallelCopy_nowait() 41 0.02557 0.04328 0.04922 1.36%
StateData::FillBoundary(geom) 41 0.03543 0.04216 0.04606 1.28%
Castro::normalize_species() 62 0.04126 0.04199 0.04243 1.17%
FillPatchIterator::Initialize 41 0.01999 0.03236 0.03698 1.02%
Gravity::interpolate_monopole_grav() 21 0.02688 0.02771 0.02802 0.78%
Castro::construct_new_gravity_source() 10 0.02001 0.02343 0.02511 0.70%
Castro::expand_state() 10 0.009561 0.01874 0.02187 0.61%
Castro::computeTemp() 63 0.01827 0.01903 0.01996 0.55%
Castro::initialize_do_advance() 10 0.00888 0.01647 0.01813 0.50%
MultiFab::Saxpy() 20 0.008681 0.01443 0.01648 0.46%
VisMF::Write(FabArray) 2 0.01112 0.01195 0.01607 0.44%
FabArray::setDomainBndry() 41 0.006183 0.01178 0.01483 0.41%
Gravity::get_new_grav_vector() 11 0.007465 0.01135 0.01272 0.35%
Amr::writePlotFile() 2 0.007158 0.01139 0.01239 0.34%
Castro::construct_old_gravity_source() 10 0.00496 0.01008 0.01194 0.33%
MultiFab::contains_nan() 20 0.009618 0.0108 0.01192 0.33%
Gravity::get_old_grav_vector() 10 0.005714 0.009644 0.01123 0.31%
Castro::initialize_advance() 10 0.003245 0.008605 0.009517 0.26%
Castro::initMFs() 1 0.005354 0.006431 0.008131 0.23%
Castro::construct_new_source() 50 0.004792 0.006462 0.007098 0.20%
Castro::enforce_min_density() 62 0.006082 0.006722 0.007097 0.20%
StateData::define() 4 0.004474 0.005266 0.006515 0.18%
main() 1 0.005094 0.00527 0.005409 0.15%
Castro::swap_state_time_levels() 10 0.002015 0.003618 0.003861 0.11%
Castro::buildMetrics() 1 0.001267 0.001512 0.001873 0.05%
Amr::coarseTimeStep() 10 0.0003838 0.0006833 0.001426 0.04%
Castro::finalize_do_advance() 10 0.0005387 0.0009969 0.001122 0.03%
Amr::timeStep() 10 0.0001724 0.0002348 0.0005084 0.01%
Amr::InitAmr() 1 0.0002877 0.0003459 0.0004417 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.000297 0.0003065 0.0003329 0.01%
DistributionMapping::LeastUsedCPUs() 1 7.354e-06 0.000129 0.0002065 0.01%
Castro::clean_state() 62 0.0001574 0.0001674 0.0001807 0.01%
StateDataPhysBCFunct::() 41 0.0001156 0.0001627 0.0001757 0.00%
Castro::enforce_consistent_e() 1 8.43e-05 9.967e-05 0.0001433 0.00%
Castro::construct_old_source() 50 4.117e-05 7.32e-05 9.629e-05 0.00%
FabArray::ParallelCopy() 41 6.166e-05 7.071e-05 8.607e-05 0.00%
FillPatchSingleLevel 41 6.769e-05 7.238e-05 8.014e-05 0.00%
Castro::do_old_sources() 10 3.963e-05 6.482e-05 7.739e-05 0.00%
Castro::Castro() 1 5.405e-05 5.917e-05 7.289e-05 0.00%
Castro::do_new_sources() 10 4.629e-05 6.403e-05 7.271e-05 0.00%
Amr::FinalizeInit() 1 3.891e-06 1.34e-05 7.154e-05 0.00%
Castro::construct_old_gravity() 10 4.221e-05 5.717e-05 7.036e-05 0.00%
Castro::subcycle_advance_ctu() 10 4.29e-05 5.643e-05 6.793e-05 0.00%
FabArrayBase::getCPC() 41 5.092e-05 5.674e-05 6.676e-05 0.00%
Amr::writeSmallPlotFile() 1 5.463e-05 6.076e-05 6.431e-05 0.00%
Castro::construct_new_gravity() 10 4.059e-05 4.726e-05 5.825e-05 0.00%
Castro::finalize_advance() 10 5.08e-05 5.376e-05 5.591e-05 0.00%
Castro::apply_source_to_state() 20 4.272e-05 4.879e-05 5.499e-05 0.00%
Castro::advance() 10 3.339e-05 4.281e-05 5.191e-05 0.00%
Amr::defBaseLevel() 1 2.689e-05 3.407e-05 4.096e-05 0.00%
Castro::enforce_speed_limit() 62 2.45e-05 2.849e-05 3.753e-05 0.00%
FabArrayBase::CPC::define() 2 2.366e-05 2.746e-05 3.172e-05 0.00%
Castro::check_for_nan() 20 2.105e-05 2.306e-05 2.781e-05 0.00%
Castro::post_timestep() 10 1.96e-05 2.109e-05 2.363e-05 0.00%
AmrLevel::AmrLevel(dm) 1 1.662e-05 1.743e-05 2.018e-05 0.00%
Castro::FluxRegCrseInit 10 8.038e-06 1.115e-05 1.635e-05 0.00%
Gravity::swapTimeLevels() 10 7.806e-06 1.307e-05 1.557e-05 0.00%
Amr::initSubcycle() 1 8.224e-06 1.041e-05 1.419e-05 0.00%
Castro::post_init() 1 8.649e-06 1.064e-05 1.416e-05 0.00%
Castro::create_source_corrector() 10 8.216e-06 1.1e-05 1.398e-05 0.00%
Castro::computeNewDt() 9 7.934e-06 1.007e-05 1.253e-05 0.00%
Gravity::set_mass_offset() 10 8.353e-06 1.081e-05 1.232e-05 0.00%
Castro::post_regrid() 1 2.118e-06 3.853e-06 8.283e-06 0.00%
Castro::retry_advance_ctu() 10 4.017e-06 6.041e-06 7.33e-06 0.00%
Amr::InitializeInit() 1 2.178e-06 2.897e-06 5.739e-06 0.00%
Castro::computeInitialDt() 2 3.895e-06 4.554e-06 5.684e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 4.155e-06 4.714e-06 5.344e-06 0.00%
Castro::FluxRegFineAdd() 10 1.745e-06 2.185e-06 2.478e-06 0.00%
Amr::init() 1 1.799e-06 2.064e-06 2.47e-06 0.00%
Amr::initialInit() 1 1.194e-06 1.445e-06 1.757e-06 0.00%
DistributionMapping::Distribute() 1 9.78e-07 1.159e-06 1.438e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.612 3.612 3.612 100.00%
Amr::coarseTimeStep() 10 3.375 3.375 3.375 93.44%
Amr::timeStep() 10 3.366 3.366 3.366 93.20%
Castro::advance() 10 3.349 3.35 3.35 92.75%
Castro::subcycle_advance_ctu() 10 3.279 3.282 3.295 91.22%
Castro::do_advance_ctu() 10 3.279 3.282 3.295 91.22%
Castro::construct_ctu_hydro_source() 10 2.046 2.354 2.457 68.01%
Gravity::make_radial_gravity() 21 0.338 0.3514 0.3791 10.50%
Castro::construct_old_gravity() 10 0.1993 0.2108 0.2324 6.43%
Gravity::get_old_grav_vector() 10 0.1984 0.21 0.2318 6.42%
Gravity::get_new_grav_vector() 11 0.2276 0.2301 0.2316 6.41%
Amr::init() 1 0.2212 0.2213 0.2214 6.13%
FillPatchIterator::Initialize 41 0.1816 0.1888 0.2116 5.86%
Amr::initialInit() 1 0.2074 0.2077 0.2079 5.75%
Castro::construct_new_gravity() 10 0.2025 0.2043 0.2057 5.69%
FillPatchSingleLevel 41 0.1297 0.1447 0.1854 5.13%
Castro::initialize_do_advance() 10 0.1576 0.1718 0.1784 4.94%
Amr::InitializeInit() 1 0.0568 0.1145 0.1782 4.93%
Amr::defBaseLevel() 1 0.05679 0.1145 0.1782 4.93%
Castro::estTimeStep() 21 0.02998 0.09388 0.1631 4.52%
Castro::initData() 1 0.04389 0.09913 0.1598 4.42%
Amr::FinalizeInit() 1 0.02923 0.09322 0.151 4.18%
FabArray::ParallelCopy() 41 0.08671 0.1023 0.1498 4.15%
Castro::expand_state() 10 0.1138 0.1249 0.1296 3.59%
FabArray::ParallelCopy_finish() 41 0.03906 0.05887 0.1241 3.43%
Castro::computeInitialDt() 2 0.001982 0.06582 0.1235 3.42%
Castro::clean_state() 62 0.1125 0.1172 0.1189 3.29%
Castro::initialize_advance() 10 0.05455 0.06814 0.07125 1.97%
Castro::computeTemp() 63 0.06588 0.06945 0.07103 1.97%
FabArray::setVal() 143 0.0549 0.06718 0.07026 1.95%
Castro::do_new_sources() 10 0.05346 0.06353 0.06556 1.82%
Castro::reset_internal_energy(MultiFab) 63 0.04761 0.05042 0.0518 1.43%
Castro::reset_internal_energy(Fab) 1008 0.04728 0.05011 0.05149 1.43%
FabArray::ParallelCopy_nowait() 41 0.02567 0.04336 0.0493 1.36%
Castro::do_old_sources() 10 0.03274 0.04524 0.04903 1.36%
StateDataPhysBCFunct::() 41 0.03555 0.04232 0.04622 1.28%
StateData::FillBoundary(geom) 41 0.03543 0.04216 0.04606 1.28%
Castro::normalize_species() 62 0.04126 0.04199 0.04243 1.17%
Castro::construct_new_source() 50 0.0248 0.0299 0.03099 0.86%
Gravity::interpolate_monopole_grav() 21 0.02688 0.02771 0.02802 0.78%
Castro::post_init() 1 0.02613 0.02658 0.02685 0.74%
Castro::construct_new_gravity_source() 10 0.02001 0.02343 0.02511 0.70%
Amr::writePlotFile() 2 0.02323 0.02334 0.02351 0.65%
Castro::apply_source_to_state() 20 0.008726 0.01448 0.01653 0.46%
MultiFab::Saxpy() 20 0.008681 0.01443 0.01648 0.46%
Castro::post_timestep() 10 0.01579 0.01596 0.01614 0.45%
VisMF::Write(FabArray) 2 0.01112 0.01195 0.01607 0.44%
FabArray::setDomainBndry() 41 0.006183 0.01178 0.01483 0.41%
Castro::construct_old_source() 50 0.005001 0.01015 0.01204 0.33%
Castro::construct_old_gravity_source() 10 0.00496 0.01008 0.01194 0.33%
Castro::check_for_nan() 20 0.009642 0.01082 0.01194 0.33%
MultiFab::contains_nan() 20 0.009618 0.0108 0.01192 0.33%
Castro::Castro() 1 0.008156 0.009885 0.01184 0.33%
Castro::initMFs() 1 0.005354 0.006431 0.008131 0.23%
Castro::computeNewDt() 9 0.007047 0.007441 0.007728 0.21%
Castro::enforce_min_density() 62 0.006082 0.006722 0.007097 0.20%
AmrLevel::AmrLevel(dm) 1 0.00449 0.005284 0.006535 0.18%
StateData::define() 4 0.004474 0.005266 0.006515 0.18%
Castro::swap_state_time_levels() 10 0.002015 0.003618 0.003861 0.11%
Castro::buildMetrics() 1 0.001381 0.001663 0.002093 0.06%
Castro::post_regrid() 1 0.001511 0.001698 0.002048 0.06%
Castro::finalize_do_advance() 10 0.0005387 0.0009969 0.001122 0.03%
Amr::InitAmr() 1 0.0002968 0.0003563 0.0004557 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.369e-05 0.0001348 0.0002128 0.01%
DistributionMapping::LeastUsedCPUs() 1 7.354e-06 0.000129 0.0002065 0.01%
Castro::enforce_consistent_e() 1 8.43e-05 9.967e-05 0.0001433 0.00%
FabArrayBase::getCPC() 41 7.558e-05 8.42e-05 9.824e-05 0.00%
Castro::finalize_advance() 10 6.117e-05 6.71e-05 7.307e-05 0.00%
Amr::writeSmallPlotFile() 1 5.463e-05 6.076e-05 6.431e-05 0.00%
Castro::enforce_speed_limit() 62 2.45e-05 2.849e-05 3.753e-05 0.00%
FabArrayBase::CPC::define() 2 2.366e-05 2.746e-05 3.172e-05 0.00%
Castro::FluxRegCrseInit 10 8.038e-06 1.115e-05 1.635e-05 0.00%
Gravity::swapTimeLevels() 10 7.806e-06 1.307e-05 1.557e-05 0.00%
Amr::initSubcycle() 1 8.224e-06 1.041e-05 1.419e-05 0.00%
Castro::create_source_corrector() 10 8.216e-06 1.1e-05 1.398e-05 0.00%
Gravity::set_mass_offset() 10 8.353e-06 1.081e-05 1.232e-05 0.00%
Castro::retry_advance_ctu() 10 4.017e-06 6.041e-06 7.33e-06 0.00%
Castro::FluxRegFineAdd() 10 1.745e-06 2.185e-06 2.478e-06 0.00%
DistributionMapping::Distribute() 1 9.78e-07 1.159e-06 1.438e-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-24-g994073b931f1) finalized