MPI initialized with 4 MPI processes
MPI initialized with thread support level 3
AMReX (22.06-33-g6f72de283c38) initialized

Starting run at 05:15:13 UTC on 2022-06-16.
Successfully read inputs file ... 

Castro git describe: 22.06-12-g556652b03
AMReX git describe: 22.06-33-g6f72de283
Microphysics git describe: 22.06-2-g35a553f4

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.040798168  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.016286134

... mhd ...!!! 

Castro::do_new_sources() time = 0.030056422

...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.1204974043

[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.718365663
[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.015179943

... mhd ...!!! 

Castro::do_new_sources() time = 0.030180539

...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.1239441873

[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.598565661
[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.015247371

... mhd ...!!! 

Castro::do_new_sources() time = 0.029884864

...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.1238095449

[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.655233741
[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.021728643

... mhd ...!!! 

Castro::do_new_sources() time = 0.054584587

...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.1206890396

[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.668182551
[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.013267422

... mhd ...!!! 

Castro::do_new_sources() time = 0.039254386

...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.1224897322

[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.658578006
[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.01334836

... mhd ...!!! 

Castro::do_new_sources() time = 0.02700449

...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.1280490138

[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.515294157
[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.013299761

... mhd ...!!! 

Castro::do_new_sources() time = 0.027280001

...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.124667848

[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.606236774
[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.013557407

... mhd ...!!! 

Castro::do_new_sources() time = 0.027167527

...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.1265930086

[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.543872943
[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.013208513

... mhd ...!!! 

Castro::do_new_sources() time = 0.027203109

...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.1244688791

[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.604024484
[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.013201425

... mhd ...!!! 

Castro::do_new_sources() time = 0.027147189

...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.1251122787

[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.573648628
[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.030294895  seconds


Ending run at 05:15:39 UTC on 2022-06-16.
Run time = 26.310623
Run time without initialization = 26.17960251

  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.31 ... 26.31 ... 26.31

-------------------------------------------------------------------------------------------
Name                                        NCalls  Excl. Min  Excl. Avg  Excl. Max   Max %
-------------------------------------------------------------------------------------------
Castro::do_advance_ctu()                        10    23.7173    23.7497    23.7667  90.33%
FabArray::ParallelCopy_finish()                168     0.3449     0.5462     0.7945   3.02%
FillPatchIterator::Initialize                  168      0.115      0.289     0.3851   1.46%
FabArray::ParallelCopy_nowait()                168     0.2042     0.2372     0.2624   1.00%
FabArray::setVal()                             137      0.154     0.1913      0.214   0.81%
Castro::reset_internal_energy(Fab)            2756     0.1736     0.1897     0.2069   0.79%
Castro::initialize_do_advance()                 10     0.1049     0.1556        0.2   0.76%
Castro::sum_integrated_quantities()             11   0.009182    0.08435     0.1923   0.73%
Amr::coarseTimeStep()                           10  0.0007257     0.1227     0.1634   0.62%
Castro::expand_state()                          10    0.06194    0.09083     0.1118   0.42%
Castro::estTimeStep()                           21    0.07236    0.08832     0.1002   0.38%
Castro::initialize_advance()                    10    0.03797    0.06119    0.09759   0.37%
Castro::construct_new_source()                  40    0.04238    0.05745    0.07637   0.29%
MultiFab::Saxpy()                               50    0.05575    0.06099    0.06697   0.25%
Castro::derive()                                58    0.04585    0.04861    0.05301   0.20%
Castro::computeTemp()                           63    0.03856    0.04358    0.04876   0.19%
Castro::normalize_species()                     62    0.03857    0.04229    0.04652   0.18%
Castro::finalize_do_advance()                   10  0.0001953    0.02547     0.0432   0.16%
Castro::construct_old_source()                  40    0.02071    0.03461     0.0397   0.15%
VisMF::Write(FabArray)                           2    0.02139    0.02482    0.02954   0.11%
Amr::writePlotFile()                             2    0.01455    0.01951    0.02263   0.09%
Castro::do_old_sources()                        10  0.0001654   0.006175    0.02171   0.08%
MultiFab::contains_nan()                        20    0.01693    0.01926    0.02156   0.08%
StateData::define()                              5    0.01789    0.01924    0.02069   0.08%
Castro::volWgtSum()                            121     0.0165     0.0187     0.0206   0.08%
Castro::enforce_min_density()                   62    0.01673    0.01834    0.02037   0.08%
Castro::swap_state_time_levels()                10    0.01524    0.01768    0.01915   0.07%
Castro::finalize_advance()                      10  0.0002501   0.003837    0.01387   0.05%
Castro::initMFs()                                1    0.01036    0.01163    0.01296   0.05%
Castro::do_new_sources()                        10  0.0001528   0.002682   0.009691   0.04%
Castro::buildMetrics()                           1   0.007429   0.008359   0.009333   0.04%
main()                                           1   0.004178   0.005393   0.006613   0.03%
Castro::initData()                               1   0.004014   0.004763   0.005358   0.02%
Castro::locWgtSum()                             33   0.004253   0.004717   0.005147   0.02%
FabArrayBase::CPC::define()                      9  0.0008545   0.001215   0.001476   0.01%
Castro::reset_internal_energy(MultiFab)         63  0.0008809   0.001015   0.001151   0.00%
Castro::subcycle_advance_ctu()                  10  3.829e-05  0.0002079  0.0007022   0.00%
Castro::enforce_consistent_e()                   1  0.0005493  0.0005618  0.0005966   0.00%
Amr::InitAmr()                                   1  0.0002979  0.0003164  0.0003648   0.00%
StateDataPhysBCFunct::()                       168    0.00025  0.0002794  0.0003322   0.00%
FabArrayBase::getCPC()                         168  0.0001939  0.0002159  0.0002337   0.00%
FabArray::setDomainBndry()                     168  0.0001688  0.0001952  0.0002296   0.00%
FabArray::ParallelCopy()                       168  0.0002133  0.0002219  0.0002255   0.00%
Castro::clean_state()                           62  0.0001819  0.0002029  0.0002148   0.00%
Castro::computeNewDt()                           9  1.697e-05  6.162e-05  0.0001899   0.00%
FillPatchSingleLevel                           168  0.0001575  0.0001673  0.0001782   0.00%
Amr::timeStep()                                 10  6.044e-05  7.343e-05  9.958e-05   0.00%
DistributionMapping::LeastUsedCPUs()             1  5.908e-06  5.448e-05  7.114e-05   0.00%
Amr::writeSmallPlotFile()                        1  4.239e-05  4.885e-05  6.353e-05   0.00%
Amr::defBaseLevel()                              1  3.236e-05  3.681e-05  4.592e-05   0.00%
Castro::enforce_speed_limit()                   62  3.974e-05  4.375e-05  4.578e-05   0.00%
Amr::FinalizeInit()                              1  6.484e-06  1.571e-05  4.226e-05   0.00%
Castro::apply_source_to_state()                 20  3.127e-05  3.499e-05  3.903e-05   0.00%
Castro::advance()                               10  3.458e-05   3.69e-05  3.896e-05   0.00%
Castro::post_timestep()                         10  2.345e-05  2.728e-05  3.495e-05   0.00%
Castro::FluxRegCrseInit                         10  1.425e-05  2.209e-05  3.356e-05   0.00%
Castro::check_for_nan()                         20  3.004e-05  3.097e-05  3.319e-05   0.00%
Castro::post_regrid()                            1  2.752e-06  9.403e-06  2.742e-05   0.00%
Castro::retry_advance_ctu()                     10  1.051e-05  1.477e-05  2.344e-05   0.00%
Castro::Castro()                                 1  1.973e-05  2.075e-05  2.276e-05   0.00%
Castro::FluxRegFineAdd()                        10  3.571e-06  7.654e-06  1.944e-05   0.00%
Amr::initialInit()                               1  1.696e-06  6.114e-06   1.85e-05   0.00%
AmrLevel::AmrLevel(dm)                           1  9.772e-06  1.307e-05  1.587e-05   0.00%
Castro::create_source_corrector()               10   1.18e-05  1.279e-05  1.328e-05   0.00%
DistributionMapping::SFCProcessorMapDoIt()       1  6.788e-06  9.149e-06  1.004e-05   0.00%
Amr::initSubcycle()                              1  8.315e-06  9.264e-06  1.002e-05   0.00%
Amr::InitializeInit()                            1  2.556e-06  3.889e-06  7.175e-06   0.00%
Castro::computeInitialDt()                       2  5.072e-06  5.574e-06  6.255e-06   0.00%
DistributionMapping::Distribute()                1  2.373e-06  2.702e-06  2.902e-06   0.00%
Amr::init()                                      1  1.625e-06  2.396e-06  2.781e-06   0.00%
Castro::post_init()                              1   1.57e-06  2.135e-06  2.693e-06   0.00%
-------------------------------------------------------------------------------------------

-------------------------------------------------------------------------------------------
Name                                        NCalls  Incl. Min  Incl. Avg  Incl. Max   Max %
-------------------------------------------------------------------------------------------
main()                                           1      26.31      26.31      26.31 100.00%
Amr::coarseTimeStep()                           10      26.14      26.14      26.14  99.36%
Amr::timeStep()                                 10      25.95      25.99      26.11  99.23%
Castro::advance()                               10      25.77       25.8      25.83  98.18%
Castro::subcycle_advance_ctu()                  10       25.6      25.62      25.66  97.51%
Castro::do_advance_ctu()                        10       25.6      25.62      25.66  97.51%
FillPatchIterator::Initialize                  168     0.9949      1.075      1.162   4.42%
FillPatchSingleLevel                           168     0.6097     0.7855      1.032   3.92%
FabArray::ParallelCopy()                       168     0.6091      0.785      1.031   3.92%
Castro::initialize_do_advance()                 10     0.8941     0.9367      1.006   3.82%
FabArray::ParallelCopy_finish()                168     0.3449     0.5462     0.7945   3.02%
Castro::expand_state()                          10     0.4711     0.4905     0.5218   1.98%
Castro::clean_state()                           62     0.2662     0.2926     0.3215   1.22%
Castro::do_new_sources()                        10     0.3031     0.3084     0.3204   1.22%
Castro::post_timestep()                         10     0.1139     0.1825     0.2995   1.14%
Castro::sum_integrated_quantities()             11    0.09968     0.1703     0.2859   1.09%
FabArray::ParallelCopy_nowait()                168     0.2052     0.2386     0.2641   1.00%
Castro::computeTemp()                           63      0.213     0.2343     0.2568   0.98%
Castro::construct_new_source()                  40     0.1761     0.2096     0.2264   0.86%
Castro::initialize_advance()                    10     0.1422     0.1795     0.2175   0.83%
FabArray::setVal()                             137      0.154     0.1913      0.214   0.81%
Castro::reset_internal_energy(MultiFab)         63     0.1745     0.1907     0.2081   0.79%
Castro::reset_internal_energy(Fab)            2756     0.1736     0.1897     0.2069   0.79%
Castro::do_old_sources()                        10     0.1255     0.1377     0.1485   0.56%
Amr::init()                                      1     0.1305     0.1306     0.1306   0.50%
Castro::estTimeStep()                           21    0.07236    0.08832     0.1002   0.38%
Castro::derive()                                58    0.08475    0.08958    0.09507   0.36%
Amr::initialInit()                               1    0.08955    0.08956    0.08956   0.34%
Amr::writePlotFile()                             2    0.07132    0.07138     0.0714   0.27%
MultiFab::Saxpy()                               50    0.05575    0.06099    0.06697   0.25%
Amr::InitializeInit()                            1    0.05443    0.06108    0.06682   0.25%
Amr::defBaseLevel()                              1    0.05443    0.06107    0.06682   0.25%
Castro::construct_old_source()                  40     0.0379    0.05175    0.05872   0.22%
Castro::normalize_species()                     62    0.03857    0.04229    0.04652   0.18%
Castro::finalize_do_advance()                   10  0.0001953    0.02547     0.0432   0.16%
Amr::FinalizeInit()                              1    0.02273    0.02847    0.03512   0.13%
Castro::computeNewDt()                           9    0.02991    0.02999    0.03018   0.11%
VisMF::Write(FabArray)                           2    0.02139    0.02482    0.02954   0.11%
Castro::Castro()                                 1    0.02268    0.02628    0.02932   0.11%
Castro::apply_source_to_state()                 20     0.0232    0.02432    0.02614   0.10%
Castro::check_for_nan()                         20    0.01696    0.01929    0.02159   0.08%
MultiFab::contains_nan()                        20    0.01693    0.01926    0.02156   0.08%
AmrLevel::AmrLevel(dm)                           1     0.0179    0.01925     0.0207   0.08%
StateData::define()                              5    0.01789    0.01924    0.02069   0.08%
Castro::volWgtSum()                            121     0.0165     0.0187     0.0206   0.08%
Castro::enforce_min_density()                   62    0.01673    0.01834    0.02037   0.08%
Castro::computeInitialDt()                       2   0.007508    0.01324    0.01989   0.08%
Castro::swap_state_time_levels()                10    0.01524    0.01768    0.01915   0.07%
Castro::initData()                               1    0.01373    0.01544    0.01667   0.06%
Castro::post_init()                              1    0.01561    0.01591    0.01618   0.06%
Castro::finalize_advance()                      10  0.0002838   0.003867     0.0139   0.05%
Castro::initMFs()                                1    0.01036    0.01163    0.01296   0.05%
Castro::buildMetrics()                           1   0.008414   0.009616    0.01074   0.04%
Castro::locWgtSum()                             33   0.004253   0.004717   0.005147   0.02%
Castro::post_regrid()                            1   0.002796   0.003077    0.00337   0.01%
FabArrayBase::getCPC()                         168   0.001048   0.001431   0.001695   0.01%
FabArrayBase::CPC::define()                      9  0.0008545   0.001215   0.001476   0.01%
Castro::enforce_consistent_e()                   1  0.0005493  0.0005618  0.0005966   0.00%
Amr::InitAmr()                                   1  0.0003071  0.0003257  0.0003731   0.00%
StateDataPhysBCFunct::()                       168    0.00025  0.0002794  0.0003322   0.00%
FabArray::setDomainBndry()                     168  0.0001688  0.0001952  0.0002296   0.00%
DistributionMapping::SFCProcessorMapDoIt()       1  1.507e-05  6.633e-05  8.379e-05   0.00%
DistributionMapping::LeastUsedCPUs()             1  5.908e-06  5.448e-05  7.114e-05   0.00%
Amr::writeSmallPlotFile()                        1  4.239e-05  4.885e-05  6.353e-05   0.00%
Castro::enforce_speed_limit()                   62  3.974e-05  4.375e-05  4.578e-05   0.00%
Castro::FluxRegCrseInit                         10  1.425e-05  2.209e-05  3.356e-05   0.00%
Castro::retry_advance_ctu()                     10  1.051e-05  1.477e-05  2.344e-05   0.00%
Castro::FluxRegFineAdd()                        10  3.571e-06  7.654e-06  1.944e-05   0.00%
Castro::create_source_corrector()               10   1.18e-05  1.279e-05  1.328e-05   0.00%
Amr::initSubcycle()                              1  8.315e-06  9.264e-06  1.002e-05   0.00%
DistributionMapping::Distribute()                1  2.373e-06  2.702e-06  2.902e-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.06-33-g6f72de283c38) finalized