MPI initialized with 4 MPI processes
MPI initialized with thread support level 3
AMReX (22.05-5-g3ca867b8cce8) initialized

Starting run at 05:14:52 UTC on 2022-05-10.
Successfully read inputs file ... 

Castro git describe: 22.05-12-gb79cf4624
AMReX git describe: 22.05-5-g3ca867b8c
Microphysics git describe: 22.05

reading extern runtime parameters ...
1 Species: 
X  
Successfully read inputs file ... 
Initializing the data at level 0
Done initializing the level 0 data 
...estimated hydro-limited timestep at level 0: 0.001128402466
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128402466


TIME= 0 MASS        = 0.00884
TIME= 0 XMOM        = -4.40186082e-17
TIME= 0 YMOM        = -9.085614205e-17
TIME= 0 ZMOM        = 0
TIME= 0 ANG MOM X   = 1.473837328e-19
TIME= 0 ANG MOM Y   = 1.904130065e-18
TIME= 0 ANG MOM Z   = -0.002813975113
TIME= 0 RHO*e       = 0.007918149254
TIME= 0 RHO*K       = 0.00442
TIME= 0 RHO*E       = 0.01392969868
TIME= 0 CENTER OF MASS X-LOC = 0.5
TIME= 0 CENTER OF MASS X-VEL = -4.979480566e-15
TIME= 0 CENTER OF MASS Y-LOC = 0.5
TIME= 0 CENTER OF MASS Y-VEL = -1.027784412e-14
TIME= 0 CENTER OF MASS Z-LOC = 0.02
TIME= 0 CENTER OF MASS Z-VEL = 0
TIME= 0 MAXIMUM TEMPERATURE  = 7.217919947e-09
TIME= 0 MAXIMUM DENSITY      = 0.221
INITIAL GRIDS 
  Level 0   49 grids  320000 cells  100 % of domain
            smallest grid: 24 x 24 x 8  biggest grid: 32 x 32 x 8

PLOTFILE: file = OrzagTag-mhd_plt00000
Write plotfile time = 0.041315584  seconds

...estimated hydro-limited timestep at level 0: 0.001128402466
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128402466

[Level 0 step 1] ADVANCE with dt = 1.128402466e-05

  Beginning subcycle 1 starting at time 0 with dt = 1.128402466e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.014889882

... mhd ...!!! 

Castro::do_new_sources() time = 0.02911629

...estimated hydro-limited timestep at level 0: 0.001128391655
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128391655

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1213910858

[Level 0 step 1] Advanced 320000 cells

TIME= 1.128402466e-05 MASS        = 0.00884
TIME= 1.128402466e-05 XMOM        = 1.517883041e-18
TIME= 1.128402466e-05 YMOM        = 8.055622142e-17
TIME= 1.128402466e-05 ZMOM        = -1.905765911e-42
TIME= 1.128402466e-05 ANG MOM X   = -2.134523027e-19
TIME= 1.128402466e-05 ANG MOM Y   = -6.979551485e-19
TIME= 1.128402466e-05 ANG MOM Z   = -0.00281397511
TIME= 1.128402466e-05 RHO*e       = 0.00791814927
TIME= 1.128402466e-05 RHO*K       = 0.004419999997
TIME= 1.128402466e-05 RHO*E       = 0.01392969868
TIME= 1.128402466e-05 CENTER OF MASS X-LOC = 0.5
TIME= 1.128402466e-05 CENTER OF MASS X-VEL = 1.717062264e-16
TIME= 1.128402466e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 1.128402466e-05 CENTER OF MASS Y-VEL = 9.11269473e-15
TIME= 1.128402466e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 1.128402466e-05 CENTER OF MASS Z-VEL = -2.155843791e-40
TIME= 1.128402466e-05 MAXIMUM TEMPERATURE  = 7.217924494e-09
TIME= 1.128402466e-05 MAXIMUM DENSITY      = 0.2210002015

[STEP 1] Coarse TimeStep time: 2.653852989
[STEP 1] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 1 TIME = 1.128402466e-05 DT = 1.128402466e-05

...estimated hydro-limited timestep at level 0: 0.001128391655
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128391655

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128391655
 ... but limiting to: 1.241242713e-05 = 1.1 * 1.128402466e-05
[Level 0 step 2] ADVANCE with dt = 1.241242713e-05

  Beginning subcycle 1 starting at time 1.128402466e-05 with dt = 1.241242713e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015224422

... mhd ...!!! 

Castro::do_new_sources() time = 0.029244709

...estimated hydro-limited timestep at level 0: 0.001128379781
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128379781

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1235618354

[Level 0 step 2] Advanced 320000 cells

TIME= 2.369645179e-05 MASS        = 0.00884
TIME= 2.369645179e-05 XMOM        = -1.973247954e-17
TIME= 2.369645179e-05 YMOM        = -2.336455682e-17
TIME= 2.369645179e-05 ZMOM        = 7.488538993e-42
TIME= 2.369645179e-05 ANG MOM X   = -2.202285663e-20
TIME= 2.369645179e-05 ANG MOM Y   = -4.946672412e-19
TIME= 2.369645179e-05 ANG MOM Z   = -0.002813975103
TIME= 2.369645179e-05 RHO*e       = 0.00791814929
TIME= 2.369645179e-05 RHO*K       = 0.004419999997
TIME= 2.369645179e-05 RHO*E       = 0.01392969868
TIME= 2.369645179e-05 CENTER OF MASS X-LOC = 0.5
TIME= 2.369645179e-05 CENTER OF MASS X-VEL = -2.232180943e-15
TIME= 2.369645179e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 2.369645179e-05 CENTER OF MASS Y-VEL = -2.643049414e-15
TIME= 2.369645179e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 2.369645179e-05 CENTER OF MASS Z-VEL = 8.471197956e-40
TIME= 2.369645179e-05 MAXIMUM TEMPERATURE  = 7.217929371e-09
TIME= 2.369645179e-05 MAXIMUM DENSITY      = 0.2210004217

[STEP 2] Coarse TimeStep time: 2.606823125
[STEP 2] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 2 TIME = 2.369645179e-05 DT = 1.241242713e-05

...estimated hydro-limited timestep at level 0: 0.001128379781
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128379781

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128379781
 ... but limiting to: 1.365366984e-05 = 1.1 * 1.241242713e-05
[Level 0 step 3] ADVANCE with dt = 1.365366984e-05

  Beginning subcycle 1 starting at time 2.369645179e-05 with dt = 1.365366984e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015209983

... mhd ...!!! 

Castro::do_new_sources() time = 0.029169953

...estimated hydro-limited timestep at level 0: 0.001128366742
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128366742

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1232504596

[Level 0 step 3] Advanced 320000 cells

TIME= 3.735012163e-05 MASS        = 0.00884
TIME= 3.735012163e-05 XMOM        = -2.168404345e-17
TIME= 3.735012163e-05 YMOM        = 4.174178364e-18
TIME= 3.735012163e-05 ZMOM        = -2.242077543e-41
TIME= 3.735012163e-05 ANG MOM X   = 1.406074692e-19
TIME= 3.735012163e-05 ANG MOM Y   = 1.294266343e-18
TIME= 3.735012163e-05 ANG MOM Z   = -0.002813975088
TIME= 3.735012163e-05 RHO*e       = 0.007918149313
TIME= 3.735012163e-05 RHO*K       = 0.00442
TIME= 3.735012163e-05 RHO*E       = 0.01392969868
TIME= 3.735012163e-05 CENTER OF MASS X-LOC = 0.5
TIME= 3.735012163e-05 CENTER OF MASS X-VEL = -2.452946092e-15
TIME= 3.735012163e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 3.735012163e-05 CENTER OF MASS Y-VEL = 4.721921226e-16
TIME= 3.735012163e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 3.735012163e-05 CENTER OF MASS Z-VEL = -2.536286813e-39
TIME= 3.735012163e-05 MAXIMUM TEMPERATURE  = 7.217934757e-09
TIME= 3.735012163e-05 MAXIMUM DENSITY      = 0.2210006622

[STEP 3] Coarse TimeStep time: 2.613225013
[STEP 3] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 3 TIME = 3.735012163e-05 DT = 1.365366984e-05

...estimated hydro-limited timestep at level 0: 0.001128366742
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128366742

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128366742
 ... but limiting to: 1.501903682e-05 = 1.1 * 1.365366984e-05
[Level 0 step 4] ADVANCE with dt = 1.501903682e-05

  Beginning subcycle 1 starting at time 3.735012163e-05 with dt = 1.501903682e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015349891

... mhd ...!!! 

Castro::do_new_sources() time = 0.029337545

...estimated hydro-limited timestep at level 0: 0.001128352424
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128352424

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1230192268

[Level 0 step 4] Advanced 320000 cells

TIME= 5.236915845e-05 MASS        = 0.00884
TIME= 5.236915845e-05 XMOM        = 1.084202172e-18
TIME= 5.236915845e-05 YMOM        = -1.463672933e-18
TIME= 5.236915845e-05 ZMOM        = 1.614295831e-42
TIME= 5.236915845e-05 ANG MOM X   = -2.371692252e-20
TIME= 5.236915845e-05 ANG MOM Y   = 5.421010862e-20
TIME= 5.236915845e-05 ANG MOM Z   = -0.002813975064
TIME= 5.236915845e-05 RHO*e       = 0.007918149341
TIME= 5.236915845e-05 RHO*K       = 0.004420000007
TIME= 5.236915845e-05 RHO*E       = 0.01392969868
TIME= 5.236915845e-05 CENTER OF MASS X-LOC = 0.5
TIME= 5.236915845e-05 CENTER OF MASS X-VEL = 1.226473046e-16
TIME= 5.236915845e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 5.236915845e-05 CENTER OF MASS Y-VEL = -1.655738612e-16
TIME= 5.236915845e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 5.236915845e-05 CENTER OF MASS Z-VEL = 1.826126506e-40
TIME= 5.236915845e-05 MAXIMUM TEMPERATURE  = 7.217940642e-09
TIME= 5.236915845e-05 MAXIMUM DENSITY      = 0.2210009246

[STEP 4] Coarse TimeStep time: 2.61804588
[STEP 4] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 4 TIME = 5.236915845e-05 DT = 1.501903682e-05

...estimated hydro-limited timestep at level 0: 0.001128352424
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128352424

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128352424
 ... but limiting to: 1.652094051e-05 = 1.1 * 1.501903682e-05
[Level 0 step 5] ADVANCE with dt = 1.652094051e-05

  Beginning subcycle 1 starting at time 5.236915845e-05 with dt = 1.652094051e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.014830805

... mhd ...!!! 

Castro::do_new_sources() time = 0.029222293

...estimated hydro-limited timestep at level 0: 0.001128336706
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128336706

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.123563024

[Level 0 step 5] Advanced 320000 cells

TIME= 6.889009896e-05 MASS        = 0.00884
TIME= 6.889009896e-05 XMOM        = 2.840609692e-17
TIME= 6.889009896e-05 YMOM        = 4.77591057e-17
TIME= 6.889009896e-05 ZMOM        = -7.246394619e-41
TIME= 6.889009896e-05 ANG MOM X   = -3.04931861e-19
TIME= 6.889009896e-05 ANG MOM Y   = -2.812149385e-19
TIME= 6.889009896e-05 ANG MOM Z   = -0.002813975028
TIME= 6.889009896e-05 RHO*e       = 0.007918149374
TIME= 6.889009896e-05 RHO*K       = 0.00442000002
TIME= 6.889009896e-05 RHO*E       = 0.01392969868
TIME= 6.889009896e-05 CENTER OF MASS X-LOC = 0.5
TIME= 6.889009896e-05 CENTER OF MASS X-VEL = 3.21335938e-15
TIME= 6.889009896e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 6.889009896e-05 CENTER OF MASS Y-VEL = 5.402613767e-15
TIME= 6.889009896e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 6.889009896e-05 CENTER OF MASS Z-VEL = -8.19727898e-39
TIME= 6.889009896e-05 MAXIMUM TEMPERATURE  = 7.217947068e-09
TIME= 6.889009896e-05 MAXIMUM DENSITY      = 0.2210012108

[STEP 5] Coarse TimeStep time: 2.606796603
[STEP 5] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 5 TIME = 6.889009896e-05 DT = 1.652094051e-05

...estimated hydro-limited timestep at level 0: 0.001128336706
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128336706

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128336706
 ... but limiting to: 1.817303456e-05 = 1.1 * 1.652094051e-05
[Level 0 step 6] ADVANCE with dt = 1.817303456e-05

  Beginning subcycle 1 starting at time 6.889009896e-05 with dt = 1.817303456e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015086562

... mhd ...!!! 

Castro::do_new_sources() time = 0.029384182

...estimated hydro-limited timestep at level 0: 0.001128319455
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128319455

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1236498015

[Level 0 step 6] Advanced 320000 cells

TIME= 8.706313351e-05 MASS        = 0.00884
TIME= 8.706313351e-05 XMOM        = -7.589415207e-18
TIME= 8.706313351e-05 YMOM        = 2.331034671e-18
TIME= 8.706313351e-05 ZMOM        = -1.212515535e-40
TIME= 8.706313351e-05 ANG MOM X   = -3.032377951e-19
TIME= 8.706313351e-05 ANG MOM Y   = 3.388131789e-19
TIME= 8.706313351e-05 ANG MOM Z   = -0.002813974978
TIME= 8.706313351e-05 RHO*e       = 0.007918149415
TIME= 8.706313351e-05 RHO*K       = 0.004420000041
TIME= 8.706313351e-05 RHO*E       = 0.01392969868
TIME= 8.706313351e-05 CENTER OF MASS X-LOC = 0.5
TIME= 8.706313351e-05 CENTER OF MASS X-VEL = -8.585311321e-16
TIME= 8.706313351e-05 CENTER OF MASS Y-LOC = 0.5
TIME= 8.706313351e-05 CENTER OF MASS Y-VEL = 2.636917048e-16
TIME= 8.706313351e-05 CENTER OF MASS Z-LOC = 0.02
TIME= 8.706313351e-05 CENTER OF MASS Z-VEL = -1.371623909e-38
TIME= 8.706313351e-05 MAXIMUM TEMPERATURE  = 7.217954079e-09
TIME= 8.706313351e-05 MAXIMUM DENSITY      = 0.2210015223

[STEP 6] Coarse TimeStep time: 2.604934849
[STEP 6] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 6 TIME = 8.706313351e-05 DT = 1.817303456e-05

...estimated hydro-limited timestep at level 0: 0.001128319455
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128319455

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128319455
 ... but limiting to: 1.999033801e-05 = 1.1 * 1.817303456e-05
[Level 0 step 7] ADVANCE with dt = 1.999033801e-05

  Beginning subcycle 1 starting at time 8.706313351e-05 with dt = 1.999033801e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015071273

... mhd ...!!! 

Castro::do_new_sources() time = 0.029244881

...estimated hydro-limited timestep at level 0: 0.001128300526
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128300526

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1233245266

[Level 0 step 7] Advanced 320000 cells

TIME= 0.0001070534715 MASS        = 0.00884
TIME= 0.0001070534715 XMOM        = 1.745565498e-16
TIME= 0.0001070534715 YMOM        = 1.219727444e-17
TIME= 0.0001070534715 ZMOM        = -2.654619811e-41
TIME= 0.0001070534715 ANG MOM X   = -5.929230631e-19
TIME= 0.0001070534715 ANG MOM Y   = -3.286487835e-19
TIME= 0.0001070534715 ANG MOM Z   = -0.002813974909
TIME= 0.0001070534715 RHO*e       = 0.007918149463
TIME= 0.0001070534715 RHO*K       = 0.004420000071
TIME= 0.0001070534715 RHO*E       = 0.01392969868
TIME= 0.0001070534715 CENTER OF MASS X-LOC = 0.5
TIME= 0.0001070534715 CENTER OF MASS X-VEL = 1.974621604e-14
TIME= 0.0001070534715 CENTER OF MASS Y-LOC = 0.5
TIME= 0.0001070534715 CENTER OF MASS Y-VEL = 1.379782177e-15
TIME= 0.0001070534715 CENTER OF MASS Z-LOC = 0.02
TIME= 0.0001070534715 CENTER OF MASS Z-VEL = -3.002963587e-39
TIME= 0.0001070534715 MAXIMUM TEMPERATURE  = 7.217961716e-09
TIME= 0.0001070534715 MAXIMUM DENSITY      = 0.221001861

[STEP 7] Coarse TimeStep time: 2.649746992
[STEP 7] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 7 TIME = 0.0001070534715 DT = 1.999033801e-05

...estimated hydro-limited timestep at level 0: 0.001128300526
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128300526

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128300526
 ... but limiting to: 2.198937181e-05 = 1.1 * 1.999033801e-05
[Level 0 step 8] ADVANCE with dt = 2.198937181e-05

  Beginning subcycle 1 starting at time 0.0001070534715 with dt = 2.198937181e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.01494927

... mhd ...!!! 

Castro::do_new_sources() time = 0.02929373

...estimated hydro-limited timestep at level 0: 0.00112827976
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.00112827976

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1266835736

[Level 0 step 8] Advanced 320000 cells

TIME= 0.0001290428433 MASS        = 0.00884
TIME= 0.0001290428433 XMOM        = -1.090707386e-16
TIME= 0.0001290428433 YMOM        = 3.198396409e-18
TIME= 0.0001290428433 ZMOM        = -4.735267771e-41
TIME= 0.0001290428433 ANG MOM X   = -3.286487835e-19
TIME= 0.0001290428433 ANG MOM Y   = 2.710505431e-20
TIME= 0.0001290428433 ANG MOM Z   = -0.002813974817
TIME= 0.0001290428433 RHO*e       = 0.007918149521
TIME= 0.0001290428433 RHO*K       = 0.004420000112
TIME= 0.0001290428433 RHO*E       = 0.01392969868
TIME= 0.0001290428433 CENTER OF MASS X-LOC = 0.5
TIME= 0.0001290428433 CENTER OF MASS X-VEL = -1.233831884e-14
TIME= 0.0001290428433 CENTER OF MASS Y-LOC = 0.5
TIME= 0.0001290428433 CENTER OF MASS Y-VEL = 3.618095485e-16
TIME= 0.0001290428433 CENTER OF MASS Z-LOC = 0.02
TIME= 0.0001290428433 CENTER OF MASS Z-VEL = -5.35663775e-39
TIME= 0.0001290428433 MAXIMUM TEMPERATURE  = 7.217970014e-09
TIME= 0.0001290428433 MAXIMUM DENSITY      = 0.2210022283

[STEP 8] Coarse TimeStep time: 2.580985645
[STEP 8] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 8 TIME = 0.0001290428433 DT = 2.198937181e-05

...estimated hydro-limited timestep at level 0: 0.00112827976
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.00112827976

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.00112827976
 ... but limiting to: 2.4188309e-05 = 1.1 * 2.198937181e-05
[Level 0 step 9] ADVANCE with dt = 2.4188309e-05

  Beginning subcycle 1 starting at time 0.0001290428433 with dt = 2.4188309e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.014851632

... mhd ...!!! 

Castro::do_new_sources() time = 0.029553083

...estimated hydro-limited timestep at level 0: 0.001128256987
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128256987

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1235692273

[Level 0 step 9] Advanced 320000 cells

TIME= 0.0001532311523 MASS        = 0.00884
TIME= 0.0001532311523 XMOM        = 5.637851297e-18
TIME= 0.0001532311523 YMOM        = -8.456776945e-18
TIME= 0.0001532311523 ZMOM        = -1.133594406e-40
TIME= 0.0001532311523 ANG MOM X   = -6.539094353e-19
TIME= 0.0001532311523 ANG MOM Y   = 1.016439537e-19
TIME= 0.0001532311523 ANG MOM Z   = -0.002813974696
TIME= 0.0001532311523 RHO*e       = 0.007918149591
TIME= 0.0001532311523 RHO*K       = 0.004420000168
TIME= 0.0001532311523 RHO*E       = 0.01392969868
TIME= 0.0001532311523 CENTER OF MASS X-LOC = 0.5
TIME= 0.0001532311523 CENTER OF MASS X-VEL = 6.377659838e-16
TIME= 0.0001532311523 CENTER OF MASS Y-LOC = 0.5
TIME= 0.0001532311523 CENTER OF MASS Y-VEL = -9.566489757e-16
TIME= 0.0001532311523 CENTER OF MASS Z-LOC = 0.02
TIME= 0.0001532311523 CENTER OF MASS Z-VEL = -1.282346613e-38
TIME= 0.0001532311523 MAXIMUM TEMPERATURE  = 7.217979013e-09
TIME= 0.0001532311523 MAXIMUM DENSITY      = 0.2210026257

[STEP 9] Coarse TimeStep time: 2.606642107
[STEP 9] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 9 TIME = 0.0001532311523 DT = 2.4188309e-05

...estimated hydro-limited timestep at level 0: 0.001128256987
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128256987

Castro::compute_new_dt : limiting dt at level 0
 ... new dt computed: 0.001128256987
 ... but limiting to: 2.660713989e-05 = 1.1 * 2.4188309e-05
[Level 0 step 10] ADVANCE with dt = 2.660713989e-05

  Beginning subcycle 1 starting at time 0.0001532311523 with dt = 2.660713989e-05
  Estimated number of subcycles remaining: 1

Castro::do_old_sources() time = 0.015277381

... mhd ...!!! 

Castro::do_new_sources() time = 0.029126082

...estimated hydro-limited timestep at level 0: 0.001128232019
Castro::estTimeStep (hydro-limited) at level 0:  estdt = 0.001128232019

  Subcycle completed

  Subcycling complete

  Zones advanced per microsecond at this level: 0.1231940665

[Level 0 step 10] Advanced 320000 cells

TIME= 0.0001798382922 MASS        = 0.00884
TIME= 0.0001798382922 XMOM        = -3.035766083e-17
TIME= 0.0001798382922 YMOM        = -2.770136551e-17
TIME= 0.0001798382922 ZMOM        = 1.635819775e-40
TIME= 0.0001798382922 ANG MOM X   = 1.185846126e-20
TIME= 0.0001798382922 ANG MOM Y   = 6.09863722e-19
TIME= 0.0001798382922 ANG MOM Z   = -0.002813974538
TIME= 0.0001798382922 RHO*e       = 0.007918149674
TIME= 0.0001798382922 RHO*K       = 0.004420000243
TIME= 0.0001798382922 RHO*E       = 0.01392969868
TIME= 0.0001798382922 CENTER OF MASS X-LOC = 0.5
TIME= 0.0001798382922 CENTER OF MASS X-VEL = -3.434124528e-15
TIME= 0.0001798382922 CENTER OF MASS Y-LOC = 0.5
TIME= 0.0001798382922 CENTER OF MASS Y-VEL = -3.133638632e-15
TIME= 0.0001798382922 CENTER OF MASS Z-LOC = 0.02
TIME= 0.0001798382922 CENTER OF MASS Z-VEL = 1.850474859e-38
TIME= 0.0001798382922 MAXIMUM TEMPERATURE  = 7.217988777e-09
TIME= 0.0001798382922 MAXIMUM DENSITY      = 0.2210030549

[STEP 10] Coarse TimeStep time: 2.6141043
[STEP 10] FAB kilobyte spread across MPI nodes: [150534 ... 190967]

STEP = 10 TIME = 0.0001798382922 DT = 2.660713989e-05

PLOTFILE: file = OrzagTag-mhd_plt00010
Write plotfile time = 0.029706983  seconds


Ending run at 05:15:18 UTC on 2022-05-10.
Run time = 26.29249217
Run time without initialization = 26.15691926

  Average number of zones advanced per microsecond: 0.122
  Average number of zones advanced per microsecond per rank: 0.031



TinyProfiler total time across processes [min...avg...max]: 26.29 ... 26.29 ... 26.29

-------------------------------------------------------------------------------------------
Name                                        NCalls  Excl. Min  Excl. Avg  Excl. Max   Max %
-------------------------------------------------------------------------------------------
Castro::do_advance_ctu()                        10    23.9057    23.9392    23.9587  91.12%
FabArray::ParallelCopy_finish()                168     0.2758     0.4542     0.7094   2.70%
FillPatchIterator::Initialize                  168     0.1147      0.283     0.3746   1.42%
FabArray::ParallelCopy_nowait()                168      0.215     0.2452     0.2644   1.01%
FabArray::setVal()                             137     0.1739     0.1974     0.2149   0.82%
Castro::reset_internal_energy(Fab)            2756     0.1758     0.1915     0.2059   0.78%
Castro::initialize_do_advance()                 10    0.09147     0.1521     0.2021   0.77%
Castro::estTimeStep()                           21    0.07015     0.1178     0.1359   0.52%
Castro::expand_state()                          10    0.08045    0.09491     0.1048   0.40%
Castro::initialize_advance()                    10    0.03879    0.06051    0.09956   0.38%
MultiFab::Saxpy()                               50    0.06853    0.07341    0.07784   0.30%
Castro::construct_new_source()                  40    0.03818    0.05385    0.06579   0.25%
Castro::sum_integrated_quantities()             11   0.009366     0.0411    0.05799   0.22%
Castro::derive()                                58    0.05088    0.05343    0.05771   0.22%
Castro::computeTemp()                           63    0.03971    0.04647    0.05376   0.20%
Castro::normalize_species()                     62    0.03865    0.04309    0.04696   0.18%
Castro::construct_old_source()                  40    0.02341    0.03511    0.04005   0.15%
Castro::finalize_do_advance()                   10  0.0001294    0.02044    0.03406   0.13%
VisMF::Write(FabArray)                           2    0.01959    0.02237    0.02742   0.10%
Amr::writePlotFile()                             2    0.01601    0.02104    0.02339   0.09%
MultiFab::contains_nan()                        20    0.01811    0.02016    0.02146   0.08%
StateData::define()                              5    0.01698    0.01874    0.02135   0.08%
Castro::volWgtSum()                            121    0.01741    0.01936    0.02103   0.08%
Castro::swap_state_time_levels()                10    0.01479    0.01705    0.02078   0.08%
Castro::enforce_min_density()                   62    0.01824    0.01949    0.02047   0.08%
Castro::initMFs()                                1    0.01083    0.01195    0.01343   0.05%
Castro::finalize_advance()                      10  0.0001936   0.003399    0.01224   0.05%
main()                                           1   0.003666   0.007503    0.01022   0.04%
Castro::buildMetrics()                           1    0.00749   0.008412   0.009847   0.04%
Castro::initData()                               1   0.004697   0.005539   0.006148   0.02%
Castro::locWgtSum()                             33   0.004856   0.005217    0.00559   0.02%
FabArrayBase::CPC::define()                      9  0.0008756   0.001221   0.001676   0.01%
Castro::reset_internal_energy(MultiFab)         63  0.0009245   0.001056   0.001171   0.00%
Castro::enforce_consistent_e()                   1  0.0005835  0.0006788   0.000869   0.00%
Castro::do_old_sources()                        10  0.0001669  0.0003761  0.0007868   0.00%
Castro::subcycle_advance_ctu()                  10  3.784e-05  0.0002256  0.0007287   0.00%
Castro::do_new_sources()                        10  0.0001544  0.0003511  0.0006984   0.00%
Amr::InitAmr()                                   1  0.0002968  0.0003257  0.0004037   0.00%
Amr::coarseTimeStep()                           10  0.0002966  0.0003304  0.0003636   0.00%
StateDataPhysBCFunct::()                       168  0.0003146  0.0003316  0.0003529   0.00%
FabArray::setDomainBndry()                     168  0.0002233  0.0002419  0.0002752   0.00%
Castro::computeNewDt()                           9  1.586e-05  8.087e-05   0.000259   0.00%
FabArrayBase::getCPC()                         168  0.0002113   0.000224  0.0002456   0.00%
FabArray::ParallelCopy()                       168  0.0002141  0.0002271  0.0002424   0.00%
Castro::clean_state()                           62  0.0001925  0.0002128  0.0002341   0.00%
FillPatchSingleLevel                           168  0.0001959  0.0002047  0.0002174   0.00%
DistributionMapping::LeastUsedCPUs()             1  6.681e-06  0.0001032  0.0001358   0.00%
Amr::timeStep()                                 10  6.401e-05  6.938e-05  8.124e-05   0.00%
Castro::advance()                               10  2.991e-05  3.983e-05  5.456e-05   0.00%
Castro::enforce_speed_limit()                   62  4.306e-05   4.88e-05   5.41e-05   0.00%
Castro::apply_source_to_state()                 20  3.499e-05   4.17e-05  4.576e-05   0.00%
Castro::check_for_nan()                         20  3.243e-05  3.853e-05  4.455e-05   0.00%
Amr::writeSmallPlotFile()                        1  2.476e-05  3.542e-05  4.352e-05   0.00%
Amr::FinalizeInit()                              1  6.149e-06  1.557e-05  4.205e-05   0.00%
Amr::defBaseLevel()                              1  2.233e-05  2.898e-05  3.346e-05   0.00%
AmrLevel::AmrLevel(dm)                           1  1.978e-05  2.529e-05  2.924e-05   0.00%
Castro::post_timestep()                         10   1.93e-05  2.158e-05  2.674e-05   0.00%
Castro::Castro()                                 1  1.825e-05  2.129e-05  2.425e-05   0.00%
Castro::retry_advance_ctu()                     10  1.098e-05  1.546e-05  2.419e-05   0.00%
Castro::FluxRegCrseInit                         10  9.166e-06  1.526e-05  2.264e-05   0.00%
Castro::create_source_corrector()               10  1.358e-05  1.617e-05  1.822e-05   0.00%
DistributionMapping::SFCProcessorMapDoIt()       1  9.135e-06  9.963e-06  1.151e-05   0.00%
Castro::post_init()                              1  1.835e-06  4.283e-06  1.051e-05   0.00%
Amr::initSubcycle()                              1  9.508e-06  9.709e-06  9.919e-06   0.00%
Amr::InitializeInit()                            1  2.396e-06   3.89e-06   7.02e-06   0.00%
Castro::computeInitialDt()                       2  4.744e-06  5.737e-06    6.4e-06   0.00%
Castro::FluxRegFineAdd()                        10  3.129e-06  3.692e-06  4.085e-06   0.00%
Castro::post_regrid()                            1  2.076e-06  3.086e-06  3.827e-06   0.00%
DistributionMapping::Distribute()                1  2.628e-06  2.722e-06  2.801e-06   0.00%
Amr::init()                                      1    2.1e-06  2.412e-06  2.644e-06   0.00%
Amr::initialInit()                               1  1.827e-06  2.002e-06  2.086e-06   0.00%
-------------------------------------------------------------------------------------------

-------------------------------------------------------------------------------------------
Name                                        NCalls  Incl. Min  Incl. Avg  Incl. Max   Max %
-------------------------------------------------------------------------------------------
main()                                           1      26.29      26.29      26.29 100.00%
Amr::coarseTimeStep()                           10      26.12      26.12      26.12  99.33%
Amr::timeStep()                                 10      26.04      26.05      26.08  99.20%
Castro::advance()                               10      25.88      25.91      25.93  98.61%
Castro::subcycle_advance_ctu()                  10      25.69      25.71      25.75  97.92%
Castro::do_advance_ctu()                        10      25.69      25.71      25.75  97.92%
FillPatchIterator::Initialize                  168     0.8938     0.9849      1.082   4.12%
FillPatchSingleLevel                           168     0.5429     0.7017     0.9673   3.68%
FabArray::ParallelCopy()                       168     0.5423     0.7011     0.9668   3.68%
Castro::initialize_do_advance()                 10     0.8555     0.8932     0.9531   3.62%
FabArray::ParallelCopy_finish()                168     0.2758     0.4542     0.7094   2.70%
Castro::expand_state()                          10     0.4483     0.4811     0.5315   2.02%
Castro::clean_state()                           62     0.2704      0.299     0.3256   1.24%
Castro::do_new_sources()                        10     0.2783     0.2831     0.2933   1.12%
FabArray::ParallelCopy_nowait()                168     0.2161     0.2467     0.2662   1.01%
Castro::computeTemp()                           63     0.2164      0.239     0.2608   0.99%
Castro::initialize_advance()                    10     0.1555     0.1869     0.2214   0.84%
FabArray::setVal()                             137     0.1739     0.1974     0.2149   0.82%
Castro::reset_internal_energy(MultiFab)         63     0.1767     0.1926     0.2071   0.79%
Castro::reset_internal_energy(Fab)            2756     0.1758     0.1915     0.2059   0.78%
Castro::construct_new_source()                  40     0.1833     0.1907     0.1999   0.76%
Castro::post_timestep()                         10      0.117     0.1491     0.1736   0.66%
Castro::sum_integrated_quantities()             11     0.1019     0.1356     0.1587   0.60%
Castro::do_old_sources()                        10     0.1337       0.14     0.1495   0.57%
Castro::estTimeStep()                           21    0.07015     0.1178     0.1359   0.52%
Amr::init()                                      1      0.135     0.1351     0.1352   0.51%
Castro::derive()                                58    0.09492     0.0978     0.1037   0.39%
Amr::initialInit()                               1    0.09355    0.09359     0.0936   0.36%
MultiFab::Saxpy()                               50    0.06853    0.07341    0.07784   0.30%
Amr::writePlotFile()                             2    0.07126    0.07132    0.07134   0.27%
Amr::InitializeInit()                            1    0.05853     0.0632    0.07036   0.27%
Amr::defBaseLevel()                              1    0.05853     0.0632    0.07035   0.27%
Castro::computeNewDt()                           9    0.02974    0.05844    0.06803   0.26%
Castro::construct_old_source()                  40    0.04535    0.05586    0.06261   0.24%
Castro::normalize_species()                     62    0.03865    0.04309    0.04696   0.18%
Amr::FinalizeInit()                              1    0.02318    0.03038    0.03506   0.13%
Castro::finalize_do_advance()                   10  0.0001294    0.02044    0.03406   0.13%
Castro::apply_source_to_state()                 20    0.02459    0.02846    0.03127   0.12%
Castro::Castro()                                 1    0.02424    0.02689    0.03068   0.12%
VisMF::Write(FabArray)                           2    0.01959    0.02237    0.02742   0.10%
Castro::check_for_nan()                         20    0.01814     0.0202     0.0215   0.08%
MultiFab::contains_nan()                        20    0.01811    0.02016    0.02146   0.08%
AmrLevel::AmrLevel(dm)                           1    0.01701    0.01877    0.02137   0.08%
StateData::define()                              5    0.01698    0.01874    0.02135   0.08%
Castro::volWgtSum()                            121    0.01741    0.01936    0.02103   0.08%
Castro::swap_state_time_levels()                10    0.01479    0.01705    0.02078   0.08%
Castro::enforce_min_density()                   62    0.01824    0.01949    0.02047   0.08%
Castro::computeInitialDt()                       2   0.008005    0.01525    0.01994   0.08%
Castro::initData()                               1    0.01637    0.01739    0.01826   0.07%
Castro::post_init()                              1    0.01552    0.01589    0.01627   0.06%
Castro::initMFs()                                1    0.01083    0.01195    0.01343   0.05%
Castro::finalize_advance()                      10  0.0002059   0.003417    0.01226   0.05%
Castro::buildMetrics()                           1     0.0086   0.009814    0.01147   0.04%
Castro::locWgtSum()                             33   0.004856   0.005217    0.00559   0.02%
Castro::post_regrid()                            1   0.002845   0.003237   0.003621   0.01%
FabArrayBase::getCPC()                         168   0.001121   0.001445   0.001896   0.01%
FabArrayBase::CPC::define()                      9  0.0008756   0.001221   0.001676   0.01%
Castro::enforce_consistent_e()                   1  0.0005835  0.0006788   0.000869   0.00%
Amr::InitAmr()                                   1  0.0003067  0.0003354  0.0004132   0.00%
StateDataPhysBCFunct::()                       168  0.0003146  0.0003316  0.0003529   0.00%
FabArray::setDomainBndry()                     168  0.0002233  0.0002419  0.0002752   0.00%
DistributionMapping::SFCProcessorMapDoIt()       1  2.088e-05  0.0001159  0.0001485   0.00%
DistributionMapping::LeastUsedCPUs()             1  6.681e-06  0.0001032  0.0001358   0.00%
Castro::enforce_speed_limit()                   62  4.306e-05   4.88e-05   5.41e-05   0.00%
Amr::writeSmallPlotFile()                        1  2.476e-05  3.542e-05  4.352e-05   0.00%
Castro::retry_advance_ctu()                     10  1.098e-05  1.546e-05  2.419e-05   0.00%
Castro::FluxRegCrseInit                         10  9.166e-06  1.526e-05  2.264e-05   0.00%
Castro::create_source_corrector()               10  1.358e-05  1.617e-05  1.822e-05   0.00%
Amr::initSubcycle()                              1  9.508e-06  9.709e-06  9.919e-06   0.00%
Castro::FluxRegFineAdd()                        10  3.129e-06  3.692e-06  4.085e-06   0.00%
DistributionMapping::Distribute()                1  2.628e-06  2.722e-06  2.801e-06   0.00%
-------------------------------------------------------------------------------------------

Unused ParmParse Variables:
  [TOP]::amr.ref_ratio(nvals = 4)  :: [2, 2, 2, 2]
  [TOP]::amr.regrid_int(nvals = 1)  :: [2]

AMReX (22.05-5-g3ca867b8cce8) finalized