MPI initialized with 8 MPI processes
MPI initialized with thread support level 3
AMReX (22.12-21-g2a8c71b8bf42) initialized
Starting run at 06:47:15 UTC on 2022-12-22.
Successfully read inputs file ...
Castro git describe: 22.12-6-g4bbdf33fa
AMReX git describe: 22.12-21-g2a8c71b8b
Microphysics git describe: 22.12-28-gdc4a7e21
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.016300211 seconds
[Level 0 step 1] ADVANCE with dt = 4.541742215e-05
[Level 0 step 1] Advanced 262144 cells
[STEP 1] Coarse TimeStep time: 0.396422363
[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.386545454
[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.334633374
[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.32986836
[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.354648673
[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.329945664
[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.312914683
[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.31172446
[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.310742589
[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.31808751
[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.010326188 seconds
Ending run at 06:47:19 UTC on 2022-12-22.
Run time = 3.591754035
Run time without initialization = 3.403205773
Average number of zones advanced per microsecond: 0.770
Average number of zones advanced per microsecond per rank: 0.096
TinyProfiler total time across processes [min...avg...max]: 3.59 ... 3.591 ... 3.592
-------------------------------------------------------------------------------------------
Name NCalls Excl. Min Excl. Avg Excl. Max Max %
-------------------------------------------------------------------------------------------
Castro::construct_ctu_hydro_source() 10 2.3415 2.3693 2.3954 66.69%
Gravity::make_radial_gravity() 21 0.3249 0.3368 0.3525 9.81%
Castro::do_advance_ctu() 10 0.0779 0.1074 0.138 3.84%
Castro::estTimeStep() 21 0.03389 0.0792 0.1262 3.51%
Castro::initData() 1 0.03846 0.07801 0.1187 3.30%
amrex::Copy() 193 0.0623 0.07265 0.08235 2.29%
FabArray::setVal() 143 0.06237 0.07006 0.08117 2.26%
FabArray::ParallelCopy_finish() 41 0.03464 0.0473 0.07098 1.98%
Castro::reset_internal_energy(Fab) 1008 0.04814 0.04986 0.05116 1.42%
Castro::normalize_species() 62 0.04095 0.04207 0.04423 1.23%
FabArray::ParallelCopy_nowait() 41 0.03695 0.04178 0.04378 1.22%
StateData::FillBoundary(geom) 41 0.03413 0.03707 0.03961 1.10%
FillPatchIterator::Initialize 41 0.02888 0.03438 0.03641 1.01%
Castro::construct_new_gravity_source() 10 0.02308 0.02706 0.03407 0.95%
Gravity::interpolate_monopole_grav() 21 0.02814 0.02851 0.02921 0.81%
Castro::computeTemp() 63 0.01867 0.01972 0.02026 0.56%
Castro::initialize_do_advance() 10 0.01245 0.01773 0.01948 0.54%
VisMF::Write(FabArray) 2 0.01338 0.01416 0.01739 0.48%
FabArray::Saxpy() 20 0.01208 0.01373 0.01453 0.40%
Castro::initialize_advance() 10 0.008658 0.01111 0.01403 0.39%
FabArray::setDomainBndry() 41 0.007786 0.01075 0.01201 0.33%
MultiFab::contains_nan() 20 0.01017 0.01108 0.01188 0.33%
Amr::writePlotFile() 2 0.007174 0.01026 0.01139 0.32%
Castro::construct_old_gravity_source() 10 0.007664 0.01045 0.01116 0.31%
Castro::initMFs() 1 0.006877 0.007188 0.008841 0.25%
main() 1 0.004982 0.005728 0.006541 0.18%
StateData::define() 4 0.005687 0.005799 0.006483 0.18%
Castro::construct_new_source() 50 0.005765 0.006117 0.00644 0.18%
Castro::enforce_min_density() 62 0.005747 0.006023 0.006259 0.17%
Castro::swap_state_time_levels() 10 0.002617 0.004402 0.004693 0.13%
Gravity::get_new_grav_vector() 11 0.002908 0.003748 0.004154 0.12%
Amr::coarseTimeStep() 10 0.001153 0.003008 0.004081 0.11%
Gravity::get_old_grav_vector() 10 0.001822 0.002287 0.002684 0.07%
Castro::buildMetrics() 1 0.001616 0.001663 0.001929 0.05%
Castro::finalize_do_advance() 10 0.0006074 0.001407 0.001674 0.05%
Castro::expand_state() 10 0.0007047 0.0008082 0.0009642 0.03%
Amr::timeStep() 10 0.000201 0.0002521 0.000421 0.01%
Amr::InitAmr() 1 0.0002665 0.0002992 0.0004055 0.01%
Castro::reset_internal_energy(MultiFab) 63 0.0002863 0.0003017 0.0003255 0.01%
Castro::clean_state() 62 0.0001433 0.000152 0.0001574 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.548e-06 0.0001079 0.0001379 0.00%
StateDataPhysBCFunct::() 41 9.167e-05 0.0001037 0.0001136 0.00%
Castro::finalize_advance() 10 8.292e-05 9.474e-05 0.0001119 0.00%
Castro::enforce_consistent_e() 1 7.664e-05 8.498e-05 9.109e-05 0.00%
Castro::Castro() 1 5.451e-05 7.102e-05 8.668e-05 0.00%
FabArray::ParallelCopy() 41 6.737e-05 7.393e-05 8.28e-05 0.00%
Castro::construct_old_source() 50 4.712e-05 7.169e-05 8.017e-05 0.00%
Amr::FinalizeInit() 1 4.193e-06 1.401e-05 8e-05 0.00%
Castro::subcycle_advance_ctu() 10 3.511e-05 4.774e-05 7.73e-05 0.00%
Amr::writeSmallPlotFile() 1 2.447e-05 5.771e-05 7.498e-05 0.00%
FillPatchSingleLevel 41 5.9e-05 6.512e-05 6.859e-05 0.00%
Castro::do_old_sources() 10 5.167e-05 6.278e-05 6.77e-05 0.00%
FabArrayBase::getCPC() 41 3.877e-05 5.258e-05 6.77e-05 0.00%
Castro::do_new_sources() 10 5.371e-05 6.088e-05 6.556e-05 0.00%
Castro::apply_source_to_state() 20 3.108e-05 4.411e-05 4.957e-05 0.00%
Castro::advance() 10 2.997e-05 4.101e-05 4.93e-05 0.00%
Castro::construct_new_gravity() 10 3.554e-05 4.014e-05 4.732e-05 0.00%
Castro::construct_old_gravity() 10 3.36e-05 3.992e-05 4.431e-05 0.00%
Castro::check_for_nan() 20 2.195e-05 2.544e-05 3.694e-05 0.00%
AmrLevel::AmrLevel(dm) 1 2.096e-05 2.699e-05 3.506e-05 0.00%
FabArrayBase::CPC::define() 2 1.996e-05 2.465e-05 3.455e-05 0.00%
Castro::enforce_speed_limit() 62 2.726e-05 2.835e-05 3.097e-05 0.00%
Gravity::set_mass_offset() 10 8.332e-06 1.244e-05 2.75e-05 0.00%
Amr::defBaseLevel() 1 1.168e-05 1.633e-05 2.091e-05 0.00%
Castro::post_timestep() 10 1.368e-05 1.732e-05 1.936e-05 0.00%
Amr::initSubcycle() 1 8.817e-06 1.042e-05 1.56e-05 0.00%
Gravity::swapTimeLevels() 10 8.629e-06 1.137e-05 1.294e-05 0.00%
Castro::create_source_corrector() 10 7.415e-06 9.728e-06 1.163e-05 0.00%
Castro::FluxRegCrseInit 10 6.758e-06 7.957e-06 9.437e-06 0.00%
Castro::computeNewDt() 9 7.068e-06 7.686e-06 8.53e-06 0.00%
DistributionMapping::SFCProcessorMapDoIt() 1 3.68e-06 5.212e-06 6.367e-06 0.00%
Castro::retry_advance_ctu() 10 4.143e-06 5.215e-06 6.031e-06 0.00%
Amr::InitializeInit() 1 1.727e-06 2.754e-06 5.064e-06 0.00%
Castro::computeInitialDt() 2 3.684e-06 4.226e-06 4.915e-06 0.00%
Castro::post_init() 1 3.145e-06 3.748e-06 4.604e-06 0.00%
Castro::post_regrid() 1 1.968e-06 3.067e-06 4.47e-06 0.00%
Castro::FluxRegFineAdd() 10 1.841e-06 2.462e-06 3.039e-06 0.00%
Amr::init() 1 1.634e-06 2.081e-06 2.447e-06 0.00%
DistributionMapping::Distribute() 1 8.25e-07 1.141e-06 1.814e-06 0.00%
Amr::initialInit() 1 1.037e-06 1.306e-06 1.804e-06 0.00%
-------------------------------------------------------------------------------------------
-------------------------------------------------------------------------------------------
Name NCalls Incl. Min Incl. Avg Incl. Max Max %
-------------------------------------------------------------------------------------------
main() 1 3.59 3.591 3.592 100.00%
Amr::coarseTimeStep() 10 3.386 3.386 3.386 94.28%
Amr::timeStep() 10 3.372 3.373 3.375 93.96%
Castro::advance() 10 3.356 3.356 3.357 93.47%
Castro::subcycle_advance_ctu() 10 3.273 3.28 3.284 91.42%
Castro::do_advance_ctu() 10 3.273 3.28 3.284 91.42%
Castro::construct_ctu_hydro_source() 10 2.342 2.369 2.395 66.69%
Gravity::make_radial_gravity() 21 0.3417 0.3537 0.3669 10.22%
Gravity::get_new_grav_vector() 11 0.2339 0.235 0.2366 6.59%
Castro::construct_old_gravity() 10 0.1949 0.2026 0.2141 5.96%
Gravity::get_old_grav_vector() 10 0.1941 0.2019 0.2135 5.94%
Castro::construct_new_gravity() 10 0.208 0.2087 0.2099 5.84%
Amr::init() 1 0.188 0.1881 0.1881 5.24%
FillPatchIterator::Initialize 41 0.1616 0.1716 0.1798 5.00%
Castro::initialize_do_advance() 10 0.1539 0.1629 0.1725 4.80%
Amr::initialInit() 1 0.1709 0.1713 0.172 4.79%
FillPatchSingleLevel 41 0.1147 0.1265 0.1424 3.96%
Amr::InitializeInit() 1 0.05984 0.09963 0.1414 3.94%
Amr::defBaseLevel() 1 0.05984 0.09962 0.1414 3.94%
Castro::estTimeStep() 21 0.03389 0.0792 0.1262 3.51%
Castro::expand_state() 10 0.1065 0.1151 0.1245 3.47%
Castro::initData() 1 0.04256 0.08206 0.1223 3.40%
Castro::clean_state() 62 0.1139 0.1172 0.1206 3.36%
Amr::FinalizeInit() 1 0.02986 0.07166 0.1113 3.10%
FabArray::ParallelCopy() 41 0.07666 0.08924 0.1081 3.01%
Castro::computeInitialDt() 2 0.002212 0.04394 0.08376 2.33%
amrex::Copy() 193 0.0623 0.07265 0.08235 2.29%
FabArray::setVal() 143 0.06237 0.07006 0.08117 2.26%
Castro::initialize_advance() 10 0.06934 0.07275 0.08024 2.23%
Castro::do_new_sources() 10 0.05951 0.06682 0.07976 2.22%
Castro::computeTemp() 63 0.06787 0.06989 0.0715 1.99%
FabArray::ParallelCopy_finish() 41 0.03464 0.0473 0.07098 1.98%
Castro::reset_internal_energy(MultiFab) 63 0.04842 0.05016 0.05146 1.43%
Castro::reset_internal_energy(Fab) 1008 0.04814 0.04986 0.05116 1.42%
Castro::do_old_sources() 10 0.04131 0.04562 0.04769 1.33%
Castro::normalize_species() 62 0.04095 0.04207 0.04423 1.23%
FabArray::ParallelCopy_nowait() 41 0.03702 0.04186 0.04385 1.22%
Castro::construct_new_source() 50 0.02915 0.03317 0.04051 1.13%
StateDataPhysBCFunct::() 41 0.03422 0.03717 0.03972 1.11%
StateData::FillBoundary(geom) 41 0.03413 0.03707 0.03961 1.10%
Castro::construct_new_gravity_source() 10 0.02308 0.02706 0.03407 0.95%
Gravity::interpolate_monopole_grav() 21 0.02814 0.02851 0.02921 0.81%
Castro::post_init() 1 0.02693 0.02736 0.02801 0.78%
Amr::writePlotFile() 2 0.0266 0.02723 0.02766 0.77%
VisMF::Write(FabArray) 2 0.01338 0.01416 0.01739 0.48%
Castro::post_timestep() 10 0.01554 0.01617 0.01732 0.48%
Castro::apply_source_to_state() 20 0.01212 0.01378 0.01457 0.41%
FabArray::Saxpy() 20 0.01208 0.01373 0.01453 0.40%
Castro::Castro() 1 0.0114 0.01161 0.01244 0.35%
FabArray::setDomainBndry() 41 0.007786 0.01075 0.01201 0.33%
Castro::check_for_nan() 20 0.01019 0.0111 0.01192 0.33%
MultiFab::contains_nan() 20 0.01017 0.01108 0.01188 0.33%
Castro::construct_old_source() 50 0.007711 0.01052 0.01124 0.31%
Castro::construct_old_gravity_source() 10 0.007664 0.01045 0.01116 0.31%
Castro::computeNewDt() 9 0.009221 0.009229 0.009235 0.26%
Castro::initMFs() 1 0.006877 0.007188 0.008841 0.25%
AmrLevel::AmrLevel(dm) 1 0.005715 0.005826 0.006518 0.18%
StateData::define() 4 0.005687 0.005799 0.006483 0.18%
Castro::enforce_min_density() 62 0.005747 0.006023 0.006259 0.17%
Castro::swap_state_time_levels() 10 0.002617 0.004402 0.004693 0.13%
Castro::finalize_advance() 10 0.00297 0.003459 0.003994 0.11%
Castro::buildMetrics() 1 0.001747 0.0018 0.002091 0.06%
Castro::finalize_do_advance() 10 0.0006074 0.001407 0.001674 0.05%
Castro::post_regrid() 1 0.001579 0.0016 0.00163 0.05%
Amr::InitAmr() 1 0.0002763 0.0003096 0.000415 0.01%
DistributionMapping::SFCProcessorMapDoIt() 1 1.215e-05 0.0001142 0.0001452 0.00%
DistributionMapping::LeastUsedCPUs() 1 7.548e-06 0.0001079 0.0001379 0.00%
FabArrayBase::getCPC() 41 6.528e-05 7.723e-05 9.195e-05 0.00%
Castro::enforce_consistent_e() 1 7.664e-05 8.498e-05 9.109e-05 0.00%
Amr::writeSmallPlotFile() 1 2.447e-05 5.771e-05 7.498e-05 0.00%
FabArrayBase::CPC::define() 2 1.996e-05 2.465e-05 3.455e-05 0.00%
Castro::enforce_speed_limit() 62 2.726e-05 2.835e-05 3.097e-05 0.00%
Gravity::set_mass_offset() 10 8.332e-06 1.244e-05 2.75e-05 0.00%
Amr::initSubcycle() 1 8.817e-06 1.042e-05 1.56e-05 0.00%
Gravity::swapTimeLevels() 10 8.629e-06 1.137e-05 1.294e-05 0.00%
Castro::create_source_corrector() 10 7.415e-06 9.728e-06 1.163e-05 0.00%
Castro::FluxRegCrseInit 10 6.758e-06 7.957e-06 9.437e-06 0.00%
Castro::retry_advance_ctu() 10 4.143e-06 5.215e-06 6.031e-06 0.00%
Castro::FluxRegFineAdd() 10 1.841e-06 2.462e-06 3.039e-06 0.00%
DistributionMapping::Distribute() 1 8.25e-07 1.141e-06 1.814e-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.12-21-g2a8c71b8bf42) finalized