SciMLLogging Integration

[jClugstor]

Checklist

• Appropriate tests were added
• Any code changes were done in a way that does not break public API
• All documentation related to code changes were updated
• The new code follows the
  contributor guidelines, in particular the SciML Style Guide and
  COLPRAC.
• Any new documentation only uses public API

Additional context

Add any other context about the problem here.

[jClugstor]

will need SciML/SciMLBase.jl#1159 to fully work

[termi-official]

Since you are already working on the logging system, is there any chance that we can have additional logging messages for the time integration loop at trace level to debug issues in the timestepping itself? Or is that too costly?

[ChrisRackauckas]

We are splitting that to a different step. First let's get the infrastructure together, then add new messages.

Or is that too costly?

Never! If it's super costly, just put it in the All preset only. Semi? Detailed. Since there's individual switching and tons of levels, the goal is to just add tons and tons of default prints and if they are costly just don't have them on by default, but if you switch to All then you just get a lot of information.

[jClugstor]

At this point anything that was behind a verbose is now under a @SciMLMessage and is controlled by an ODEVerbosity.

Currently, the linear_verbosity and nonlinear_verbosity fields are not used because those get set in alg_cache or build_nlsolver which do not have access to the integrator or the DEOptions where the verbosity object is. So setting those in ODEVerbosity will not do anything.

For the Linear solves and Nonlinear solves I set verbose to Minimal() to prevent unnecessary printing from those during an ODE solve.

[ChrisRackauckas]

is this ready to review?

[jClugstor]

Yep, ready to be looked at.

[ChrisRackauckas]

Lots of test failures

[jClugstor]

Yes, because I'm using Minimal() for verbose for the Nonlinear and Linear solves, and they can't handle that until
SciML/NonlinearSolve.jl#647 and
SciML/LinearSolve.jl#756

[jClugstor]

There are a lot of

ERROR: LoadError: Unsatisfiable requirements detected for package OrdinaryDiffEqCore [bbf590c4]:
 OrdinaryDiffEqCore [bbf590c4] log:
 ├─possible versions are: 1.0.0-1.36.0 or uninstalled
 └─restricted to versions 1.37.0-1 by OrdinaryDiffEq [1dea7af3] — no versions left
   └─OrdinaryDiffEq [1dea7af3] log:
     ├─possible versions are: 6.103.0 or uninstalled
     └─OrdinaryDiffEq [1dea7af3] is fixed to version 6.103.0

which is weird because I bumped OrdinaryDiffEq to 1.37 in this PR, is CI not using the versions in this PR?

[ChrisRackauckas]

LTS ignores sources

[ChrisRackauckas]

DiffEqDocs needs a PR that explains it in more detail how it's a solver-package specific thing.

[ChrisRackauckas]

Actually it makes it a bit rough for it to be solver-specific... since then you cannot do things in benchmarks and optimization more generally.

[ChrisRackauckas]

why is this required?

[ChrisRackauckas]

This is very type unstable... is it supposed to be a generated function?

[ChrisRackauckas]

This isn't fixed so it's clear why you have boxing.

[jClugstor]

That's not used anywhere in the constructors, or anywhere else for that matter.

[ChrisRackauckas]

Then just cut it. It's dead code.

[ChrisRackauckas]

linear_verbosity should be Minimal still, so should nonlinear_verbosity.

[jClugstor]

Yes, that's handled by the default constructor

[ChrisRackauckas]

this should be passing it on from the verbose.

[jClugstor]

all the linear and nonlinear verbosity specifiers are now coming from the ODEVerbosity.
I had to add an argument to alg_cache in order to pass the verbosity object on to the initialization of the linear and nonlinear caches

[jClugstor]

Is there anything I can do about errors like this?

Failed to precompile OrdinaryDiffEqAdamsBashforthMoulton [89bda076-bce5-4f1c-845f-551c83cdda9a] to "/home/chrisrackauckas/.julia/compiled/v1.12/OrdinaryDiffEqAdamsBashforthMoulton/jl_QB6FLI".
ERROR: LoadError: Error opening package file /home/chrisrackauckas/.julia/compiled/v1.12/OrdinaryDiffEqCore/SoYJU_894Ui.so: /home/chrisrackauckas/.julia/compiled/v1.12/OrdinaryDiffEqCore/SoYJU_894Ui.so: cannot open shared object file: No such file or directory

[jClugstor]

@ChrisRackauckas I think this is ready, but it's hard to tell with all of the test failures. Most of them are because LTS doesn't use sources, some are from JET, and some are failures to open .so files. But I went through as many of the legitimate failures that I could find and fixed them. I also bumped all of minor versions of every subpackage to reflect that.

The biggest issue here turned out to be that in order to get the Linear and Nonlinear verbosity objects to the linear and nonlinear caches I had to add an argument to every alg_cache function and call, as well as build_nlsolver. This messes up DelayDiffEq and StochasticDiffEq, since DelayDiffEq uses OrdinaryDiffEq.alg_cache and StochasticDiffEq uses build_nlsolver. The solution for that is probably to just update those to SciMLLogging? But that will take a day or two probably.

But yeah not sure if it's mergable in this state.

[ChrisRackauckas]

The biggest issue here turned out to be that in order to get the Linear and Nonlinear verbosity objects to the linear and nonlinear caches I had to add an argument to every alg_cache function and call, as well as build_nlsolver. This messes up DelayDiffEq and StochasticDiffEq, since DelayDiffEq uses OrdinaryDiffEq.alg_cache and StochasticDiffEq uses build_nlsolver. The solution for that is probably to just update those to SciMLLogging? But that will take a day or two probably.

Yes, make the downstream PRs. But this should be easy to make backwards compatible with just the standard tricks right? Just make verbose be the last argument and make a dispatch that has a default verbose=ODEVerbosity(), so that it just adds the arg and passes down. Label it in a deprecated.jl file for future removal. Do this on alg_cache and build_nlsolver. Then downstream will work, just ignoring the verbosity argument until updated.

[jClugstor]

Running Lotka-Volterra with Tsit5

using OrdinaryDiffEq
using Chairmarks

function lotka_volterra!(du, u, p, t)
    x, y = u
    α, β, γ, δ = p
    du[1] = α * x - β * x * y      # prey growth - predation
    du[2] = -γ * y + δ * x * y     # predator death + growth from predation
end

u0 = [1.0, 1.0]  # Initial prey and predator populations

tspan = (0.0, 100.0)

p = [1.5, 1.0, 3.0, 1.0]

prob = ODEProblem(lotka_volterra!, u0, tspan, p)

Current Release:

(CurrentODE) pkg> st
Status `~/Documents/Work/Testing/ODEVerbosityTesting/CurrentODE/Project.toml`
  [0ca39b1e] Chairmarks v1.3.1
  [1dea7af3] OrdinaryDiffEq v6.103.0
  
@b solve(prob, Tsit5())
        140.069 μs (5586 allocs: 246.398 KiB)

This branch:

(NewODE) pkg> st
Status `~/Documents/Work/Testing/ODEVerbosityTesting/NewODE/Project.toml`
  [0ca39b1e] Chairmarks v1.3.1
  [3263718b] ImplicitDiscreteSolve v1.3.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/ImplicitDiscreteSolve`
  [1dea7af3] OrdinaryDiffEq v6.103.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl`
  [89bda076] OrdinaryDiffEqAdamsBashforthMoulton v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqAdamsBashforthMoulton`
  [6ad6398a] OrdinaryDiffEqBDF v1.11.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqBDF`
  [bbf590c4] OrdinaryDiffEqCore v1.37.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqCore`
  [50262376] OrdinaryDiffEqDefault v1.9.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqDefault`
  [4302a76b] OrdinaryDiffEqDifferentiation v1.17.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqDifferentiation`
  [9286f039] OrdinaryDiffEqExplicitRK v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqExplicitRK`
  [e0540318] OrdinaryDiffEqExponentialRK v1.9.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqExponentialRK`
  [becaefa8] OrdinaryDiffEqExtrapolation v1.10.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqExtrapolation`
  [5960d6e9] OrdinaryDiffEqFIRK v1.17.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqFIRK`
  [101fe9f7] OrdinaryDiffEqFeagin v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqFeagin`
  [d3585ca7] OrdinaryDiffEqFunctionMap v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqFunctionMap`
  [d28bc4f8] OrdinaryDiffEqHighOrderRK v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqHighOrderRK`
  [9f002381] OrdinaryDiffEqIMEXMultistep v1.8.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqIMEXMultistep`
  [521117fe] OrdinaryDiffEqLinear v1.7.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqLinear`
  [1344f307] OrdinaryDiffEqLowOrderRK v1.7.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqLowOrderRK`
  [b0944070] OrdinaryDiffEqLowStorageRK v1.8.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqLowStorageRK`
  [127b3ac7] OrdinaryDiffEqNonlinearSolve v1.16.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqNonlinearSolve`
  [c9986a66] OrdinaryDiffEqNordsieck v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqNordsieck`
  [5dd0a6cf] OrdinaryDiffEqPDIRK v1.7.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqPDIRK`
  [5b33eab2] OrdinaryDiffEqPRK v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqPRK`
  [04162be5] OrdinaryDiffEqQPRK v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqQPRK`
  [af6ede74] OrdinaryDiffEqRKN v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqRKN`
  [43230ef6] OrdinaryDiffEqRosenbrock v1.19.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqRosenbrock`
  [2d112036] OrdinaryDiffEqSDIRK v1.8.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqSDIRK`
  [dc97f408] OrdinaryDiffEqSIMDRK v1.2.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqSIMDRK`
  [669c94d9] OrdinaryDiffEqSSPRK v1.8.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqSSPRK`
  [e3e12d00] OrdinaryDiffEqStabilizedIRK v1.7.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqStabilizedIRK`
  [358294b1] OrdinaryDiffEqStabilizedRK v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqStabilizedRK`
  [fa646aed] OrdinaryDiffEqSymplecticRK v1.8.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqSymplecticRK`
  [9c7f1690] OrdinaryDiffEqTaylorSeries v1.5.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqTaylorSeries`
  [b1df2697] OrdinaryDiffEqTsit5 v1.6.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqTsit5`
  [79d7bb75] OrdinaryDiffEqVerner v1.7.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/OrdinaryDiffEqVerner`
  [a6db7da4] SciMLLogging v1.5.0
  [8b67ef88] SimpleImplicitDiscreteSolve v1.3.0 `~/Documents/Work/dev/OrdinaryDiffEq.jl/lib/SimpleImplicitDiscreteSolve`

@b solve(prob, Tsit5())
        95.155 μs (5585 allocs: 246.367 KiB)

With Verbose All, to prove that the logging macro is being hit:

julia> @time solve(prob, Tsit5(), verbose = SciMLLogging.All())
[ Info: Step accepted: t = 0.0776084743154256, dt = 0.0776084743154256, EEst = 1.7411597095957452e-5
[ Info: Step accepted: t = 0.2326451370670694, dt = 0.15503666275164382, EEst = 0.0004494369637330534
[ Info: Step accepted: t = 0.42911851563726466, dt = 0.19647337857019528, EEst = 0.0010314348713225967
[ Info: Step accepted: t = 0.679082199936808, dt = 0.2499636842995433, EEst = 0.006047371525635104
[ Info: Step accepted: t = 0.9444046279774128, dt = 0.2653224280406048, EEst = 0.006233884976514596
[ Info: Step accepted: t = 1.2674601918628516, dt = 0.323055563885439, EEst = 0.014071472460969837
[ Info: Step accepted: t = 1.61929140093895, dt = 0.3518312090760984, EEst = 0.030084814641352785
[ Info: Step accepted: t = 1.9869755481702074, dt = 0.3676841472312573, EEst = 0.47962121180354594
[ Info: Step accepted: t = 2.2640903679981617, dt = 0.2771148198279543, EEst = 0.6752468106673417
[ Info: Step accepted: t = 2.5125486833621076, dt = 0.2484583153639458, EEst = 0.5727708355252535
[ Info: Step accepted: t = 2.746828291948325, dt = 0.2342796085862172, EEst = 0.07251152644220916
[ Info: Step accepted: t = 3.038006876853378, dt = 0.2911785849050533, EEst = 0.09910999218200756
[ Info: Step accepted: t = 3.331621350234373, dt = 0.2936144733809947, EEst = 0.026722835147641063
[ Info: Step accepted: t = 3.6963317041618486, dt = 0.3647103539274757, EEst = 0.03080726171199388
[ Info: Step accepted: t = 4.096210659751601, dt = 0.399878955589752, EEst = 0.09334138965125895
[ Info: Step accepted: t = 4.475917398160861, dt = 0.37970673840925995, EEst = 0.021892099022485942
[ Info: Step accepted: t = 4.95860050018038, dt = 0.4826831020195195, EEst = 0.1863734789858727
[ Info: Step rejected: t = 4.95860050018038, EEst = 1.1539507678726837
[ Info: Step accepted: t = 5.315713548717359, dt = 0.35711304853697895, EEst = 0.5392346502192101
[ Info: Step accepted: t = 5.622073860466877, dt = 0.3063603117495175, EEst = 0.771334299879214
[ Info: Step accepted: t = 5.894219440111569, dt = 0.27214557964469255, EEst = 0.49310883221132085
[ Info: Step accepted: t = 6.1590770749678905, dt = 0.2648576348563215, EEst = 0.13985797806046507
[ Info: Step accepted: t = 6.455761567904413, dt = 0.29668449293652227, EEst = 0.08031187986184596
[ Info: Step accepted: t = 6.78049521291505, dt = 0.324733645010637, EEst = 0.02984422308093627
[ Info: Step accepted: t = 7.171039151123403, dt = 0.39054393820835304, EEst = 0.041886617275923334
[ Info: Step accepted: t = 7.5848624442719235, dt = 0.41382329314852073, EEst = 0.11074154705483585
[ Info: Step accepted: t = 7.978067891667038, dt = 0.3932054473951147, EEst = 0.022399079079299056
[ Info: Step accepted: t = 8.483164641366145, dt = 0.505096749699107, EEst = 0.39478988384250796
[ Info: Step rejected: t = 8.483164641366145, EEst = 14.675478890782864
[ Info: Step accepted: t = 8.719247691882519, dt = 0.23608305051637352, EEst = 0.33425703652656635
[ Info: Step accepted: t = 8.949206449510513, dt = 0.22995875762799442, EEst = 0.13485212116711692
[ Info: Step accepted: t = 9.200184762926114, dt = 0.2509783134156009, EEst = 0.22013952781077648
[ Info: Step accepted: t = 9.438028551201125, dt = 0.23784378827501063, EEst = 0.07262259758710446
[ Info: Step accepted: t = 9.711807820573478, dt = 0.2737792693723536, EEst = 0.06697735175420243
[ Info: Step accepted: t = 10.003481950970947, dt = 0.2916741303974698, EEst = 0.020662071626870948
[ Info: Step accepted: t = 10.367476667117936, dt = 0.36399471614698914, EEst = 0.026485826610427587
[ Info: Step accepted: t = 10.766804255913545, dt = 0.399327588795609, EEst = 0.0946262635006502
[ Info: Step accepted: t = 11.140713106087782, dt = 0.3739088501742362, EEst = 0.009470275975742114
[ Info: Step accepted: t = 11.675774764708203, dt = 0.5350616586204205, EEst = 0.43935410199340125
[ Info: Step rejected: t = 11.675774764708203, EEst = 2.44769392183149
[ Info: Step accepted: t = 11.971291258944499, dt = 0.29551649423629495, EEst = 0.4852604196464356
[ Info: Step accepted: t = 12.246848637313724, dt = 0.2755573783692256, EEst = 0.12811766907107905
[ Info: Step rejected: t = 12.246848637313724, EEst = 1.3170803345838447
[ Info: Step accepted: t = 12.517100315701738, dt = 0.2702516783880139, EEst = 0.5338901218659855
[ Info: Step accepted: t = 12.74240822487984, dt = 0.22530790917810306, EEst = 0.05189247107280454
[ Info: Step accepted: t = 13.034219941645663, dt = 0.2918117167658236, EEst = 0.08706437874546348
[ Info: Step accepted: t = 13.325947866379956, dt = 0.2917279247342929, EEst = 0.019820422649799375
[ Info: Step accepted: t = 13.699898532669284, dt = 0.37395066628932816, EEst = 0.02922423814897413
[ Info: Step accepted: t = 14.10319135405043, dt = 0.40329282138114675, EEst = 0.10033751059096768
[ Info: Step accepted: t = 14.480692302233262, dt = 0.3775009481828312, EEst = 0.004831859425235293
[ Info: Step accepted: t = 15.077047078765975, dt = 0.5963547765327138, EEst = 0.7554880435925589
[ Info: Step rejected: t = 15.077047078765975, EEst = 6.581199640082259
[ Info: Step accepted: t = 15.328930627570182, dt = 0.2518835488042064, EEst = 0.3998924154834684
[ Info: Step accepted: t = 15.580948806607148, dt = 0.252018179036966, EEst = 0.21423769561374412
[ Info: Step accepted: t = 15.842469695033346, dt = 0.2615208884261983, EEst = 0.2386493638785475
[ Info: Step accepted: t = 16.096762128629027, dt = 0.2542924335956817, EEst = 0.10055822679522836
[ Info: Step accepted: t = 16.378249585480482, dt = 0.2814874568514564, EEst = 0.06602548707279486
[ Info: Step accepted: t = 16.686663909084473, dt = 0.30841432360399135, EEst = 0.023199548167747417
[ Info: Step accepted: t = 17.064917822112097, dt = 0.3782539130276245, EEst = 0.031230997400109636
[ Info: Step accepted: t = 17.474201384991193, dt = 0.4092835628790966, EEst = 0.10699261755381331
[ Info: Step accepted: t = 17.855905280238037, dt = 0.3817038952468432, EEst = 0.013309232877147964
[ Info: Step accepted: t = 18.3818462487355, dt = 0.5259409684974616, EEst = 0.44695032252191397
[ Info: Step rejected: t = 18.3818462487355, EEst = 8.00062139909141
[ Info: Step accepted: t = 18.63412535427954, dt = 0.25227910554404226, EEst = 0.3846973683795177
[ Info: Step accepted: t = 18.87747150490939, dt = 0.24334615062985118, EEst = 0.16565889109299672
[ Info: Step accepted: t = 19.13844264165793, dt = 0.2609711367485414, EEst = 0.34531373781457253
[ Info: Step accepted: t = 19.374503139068803, dt = 0.23606049741087046, EEst = 0.06673532645643776
[ Info: Step accepted: t = 19.659546496921372, dt = 0.28504335785257023, EEst = 0.0770071282630323
[ Info: Step accepted: t = 19.955341730991737, dt = 0.29579523407036595, EEst = 0.020651741770134308
[ Info: Step accepted: t = 20.328647709507695, dt = 0.3733059785159593, EEst = 0.02820769795117266
[ Info: Step accepted: t = 20.734578214570316, dt = 0.4059305050626203, EEst = 0.10310717967732994
[ Info: Step accepted: t = 21.11203233821896, dt = 0.37745412364864434, EEst = 0.003944221795585607
[ Info: Step accepted: t = 21.726832445778797, dt = 0.6148001075598369, EEst = 0.7959324899348666
[ Info: Step rejected: t = 21.726832445778797, EEst = 9.203983125423976
[ Info: Step accepted: t = 21.968834277702168, dt = 0.24200183192337005, EEst = 0.3714386841962904
[ Info: Step accepted: t = 22.21449918691375, dt = 0.24566490921158124, EEst = 0.16467359326600328
[ Info: Step accepted: t = 22.47743882745091, dt = 0.2629396405371606, EEst = 0.16165799201163594
[ Info: Step accepted: t = 22.741817737127512, dt = 0.26437890967660194, EEst = 0.11561075861037898
[ Info: Step accepted: t = 23.020004251923563, dt = 0.2781865147960503, EEst = 0.056093235387126496
[ Info: Step accepted: t = 23.335339233374008, dt = 0.31533498145044314, EEst = 0.023854815205213396
[ Info: Step accepted: t = 23.715583504092557, dt = 0.3802442707185489, EEst = 0.03503206780092517
[ Info: Step accepted: t = 24.121361573556857, dt = 0.4057780694643009, EEst = 0.0972534388314139
[ Info: Step accepted: t = 24.508423199353018, dt = 0.3870616257961607, EEst = 0.020293731767606384
[ Info: Step accepted: t = 25.007341757214352, dt = 0.49891855786133266, EEst = 0.35761312910432175
[ Info: Step rejected: t = 25.007341757214352, EEst = 9.899491471580827
[ Info: Step accepted: t = 25.255222253400312, dt = 0.24788049618596047, EEst = 0.36539990495753444
[ Info: Step accepted: t = 25.49179705672843, dt = 0.23657480332811762, EEst = 0.14517743217059584
[ Info: Step accepted: t = 25.74917358586456, dt = 0.257376529136131, EEst = 0.3168782306038359
[ Info: Step accepted: t = 25.982326985311204, dt = 0.2331533994466431, EEst = 0.061119868849675754
[ Info: Step accepted: t = 26.26539315596637, dt = 0.2830661706551642, EEst = 0.07585184064284774
[ Info: Step accepted: t = 26.557695790625104, dt = 0.2923026346587367, EEst = 0.01994344035613056
[ Info: Step accepted: t = 26.927952708674297, dt = 0.37025691804919203, EEst = 0.026969895973572012
[ Info: Step accepted: t = 27.33197610254727, dt = 0.40402339387297326, EEst = 0.09901037530889535
[ Info: Step accepted: t = 27.708439673360694, dt = 0.3764635708134239, EEst = 0.004630951937992709
[ Info: Step accepted: t = 28.306064027514452, dt = 0.5976243541537594, EEst = 0.7308684549180695
[ Info: Step rejected: t = 28.306064027514452, EEst = 6.445279295872341
[ Info: Step accepted: t = 28.559538584313668, dt = 0.25347455679921616, EEst = 0.3996004376801996
[ Info: Step accepted: t = 28.812502091605698, dt = 0.2529635072920283, EEst = 0.21039208336016005
[ Info: Step accepted: t = 29.075655057341095, dt = 0.2631529657353985, EEst = 0.2350704000207897
[ Info: Step accepted: t = 29.33170522229894, dt = 0.25605016495784344, EEst = 0.09845726419525806
[ Info: Step accepted: t = 29.61563312561578, dt = 0.2839279033168407, EEst = 0.06567607278268363
[ Info: Step accepted: t = 29.92642760005339, dt = 0.3107944744376097, EEst = 0.022610258168691853
[ Info: Step accepted: t = 30.30881700753198, dt = 0.3823894074785907, EEst = 0.033603388765313234
[ Info: Step accepted: t = 30.7175118233073, dt = 0.40869481577532124, EEst = 0.10188876196653558
[ Info: Step accepted: t = 31.103537610603244, dt = 0.38602578729594167, EEst = 0.018250212214290733
[ Info: Step accepted: t = 31.610449315866497, dt = 0.5069117052632537, EEst = 0.37079786615652177
[ Info: Step rejected: t = 31.610449315866497, EEst = 9.416432811348285
[ Info: Step accepted: t = 31.860652718267325, dt = 0.25020340240082684, EEst = 0.3689673202740876
[ Info: Step accepted: t = 32.09981229094022, dt = 0.2391595726728944, EEst = 0.1494287497890957
[ Info: Step accepted: t = 32.35915412209135, dt = 0.25934183115112264, EEst = 0.3282061251051526
[ Info: Step accepted: t = 32.593475849496144, dt = 0.2343217274047963, EEst = 0.06121141148093837
[ Info: Step accepted: t = 32.87870100999083, dt = 0.28522516049468216, EEst = 0.07660842429971616
[ Info: Step accepted: t = 33.17285955170846, dt = 0.2941585417176349, EEst = 0.019768111296947697
[ Info: Step accepted: t = 33.54622429875625, dt = 0.3733647470477847, EEst = 0.027306487508233543
[ Info: Step accepted: t = 33.952644894592424, dt = 0.4064205958361743, EEst = 0.10149228991140553
[ Info: Step accepted: t = 34.330407634447354, dt = 0.37776273985492687, EEst = 0.004422528988958111
[ Info: Step accepted: t = 34.935166833242796, dt = 0.6047591987954398, EEst = 0.7270821412789544
[ Info: Step rejected: t = 34.935166833242796, EEst = 8.6694511334868
[ Info: Step accepted: t = 35.18051327860177, dt = 0.24534644535897518, EEst = 0.3747402647354286
[ Info: Step accepted: t = 35.427470551142434, dt = 0.246957272540663, EEst = 0.16887421068189667
[ Info: Step accepted: t = 35.691049881673166, dt = 0.2635793305307284, EEst = 0.17591704643903655
[ Info: Step accepted: t = 35.9534813642275, dt = 0.2624314825543316, EEst = 0.10670730393854812
[ Info: Step accepted: t = 36.23463053680135, dt = 0.28114917257384864, EEst = 0.0584069431533317
[ Info: Step accepted: t = 36.54949928247511, dt = 0.3148687456737654, EEst = 0.02270013087908032
[ Info: Step accepted: t = 36.93306897656825, dt = 0.38356969409313846, EEst = 0.036451837797082935
[ Info: Step accepted: t = 37.33851249776208, dt = 0.4054435211938328, EEst = 0.09368258975991654
[ Info: Step accepted: t = 37.72851913931432, dt = 0.3900066415522385, EEst = 0.022404230821893724
[ Info: Step accepted: t = 38.22283560473354, dt = 0.49431646541921465, EEst = 0.3330986851073174
[ Info: Step rejected: t = 38.22283560473354, EEst = 11.015175095743874
[ Info: Step accepted: t = 38.46914756540178, dt = 0.2463119606682396, EEst = 0.3548328132725526
[ Info: Step accepted: t = 38.7038566421889, dt = 0.23470907678712413, EEst = 0.13689752502625704
[ Info: Step accepted: t = 38.960705718468084, dt = 0.2568490762791788, EEst = 0.284123156678626
[ Info: Step accepted: t = 39.195854193061315, dt = 0.23514847459322913, EEst = 0.06098317418329681
[ Info: Step accepted: t = 39.47895135006315, dt = 0.283097157001832, EEst = 0.07350599407975791
[ Info: Step accepted: t = 39.77252127119528, dt = 0.293569921132131, EEst = 0.019356135912973953
[ Info: Step accepted: t = 40.145005407774505, dt = 0.3724841365792253, EEst = 0.026547540963437817
[ Info: Step accepted: t = 40.5513857839174, dt = 0.40638037614288963, EEst = 0.10032084750471945
[ Info: Step accepted: t = 40.92887284134148, dt = 0.3774870574240854, EEst = 0.004723050903969977
[ Info: Step accepted: t = 41.52710135714999, dt = 0.5982285158085058, EEst = 0.6890206730427798
[ Info: Step rejected: t = 41.52710135714999, EEst = 8.216752881741826
[ Info: Step accepted: t = 41.77477590447689, dt = 0.24767454732689997, EEst = 0.3782895301364093
[ Info: Step accepted: t = 42.02267825940267, dt = 0.24790235492577714, EEst = 0.1737973308094914
[ Info: Step accepted: t = 42.28640181757113, dt = 0.2637235581684652, EEst = 0.18874427562906673
[ Info: Step accepted: t = 42.54699683049833, dt = 0.26059501292719667, EEst = 0.10114026647237559
[ Info: Step accepted: t = 42.8298709155573, dt = 0.28287408505897316, EEst = 0.06033329521351806
[ Info: Step accepted: t = 43.14388656607042, dt = 0.31401565051311914, EEst = 0.022069406252007227
[ Info: Step accepted: t = 43.52893009290921, dt = 0.3850435268387835, EEst = 0.03670904405257545
[ Info: Step accepted: t = 43.934614253212175, dt = 0.40568416030296994, EEst = 0.09284950125203206
[ Info: Step accepted: t = 44.32556182808097, dt = 0.3909475748687955, EEst = 0.022979253428802384
[ Info: Step accepted: t = 44.818958791915875, dt = 0.4933969638349008, EEst = 0.32495048451047576
[ Info: Step rejected: t = 44.818958791915875, EEst = 11.339078845213036
[ Info: Step accepted: t = 45.065166158098265, dt = 0.2462073661823897, EEst = 0.35177013417575104
[ Info: Step accepted: t = 45.2995958987649, dt = 0.2344297406666346, EEst = 0.13386069850236765
[ Info: Step accepted: t = 45.5567674397056, dt = 0.25717154094070394, EEst = 0.27537109511772406
[ Info: Step accepted: t = 45.792820422897265, dt = 0.23605298319166332, EEst = 0.060818747014112114
[ Info: Step accepted: t = 46.076403567991626, dt = 0.28358314509435856, EEst = 0.07279838694632432
[ Info: Step accepted: t = 46.3708121349514, dt = 0.2944085669597729, EEst = 0.019085957382449854
[ Info: Step accepted: t = 46.744806488436645, dt = 0.3739943534852467, EEst = 0.026608241436940166
[ Info: Step accepted: t = 47.152245857390554, dt = 0.4074393689539109, EEst = 0.10070359412542244
[ Info: Step accepted: t = 47.53058417203458, dt = 0.37833831464402934, EEst = 0.0066082665631121505
[ Info: Step accepted: t = 48.1027947514651, dt = 0.572210579430517, EEst = 0.5728133348093252
[ Info: Step rejected: t = 48.1027947514651, EEst = 7.505437035178184
[ Info: Step accepted: t = 48.355709652147674, dt = 0.25291490068257394, EEst = 0.38518973212610574
[ Info: Step accepted: t = 48.60451556613494, dt = 0.24880591398726795, EEst = 0.18179013379783474
[ Info: Step accepted: t = 48.86791695536138, dt = 0.26340138922644085, EEst = 0.2448383363500492
[ Info: Step accepted: t = 49.119791118277206, dt = 0.2518741629158244, EEst = 0.08408611723952336
[ Info: Step accepted: t = 49.4062613576171, dt = 0.2864702393398913, EEst = 0.0676178274861769
[ Info: Step accepted: t = 49.7146432487511, dt = 0.30838189113400283, EEst = 0.020718919284670317
[ Info: Step accepted: t = 50.099633379336666, dt = 0.38499013058556375, EEst = 0.033837545988462385
[ Info: Step accepted: t = 50.50784280487334, dt = 0.40820942553667766, EEst = 0.09747273153930244
[ Info: Step accepted: t = 50.896022532302375, dt = 0.3881797274290349, EEst = 0.02023610555867191
[ Info: Step accepted: t = 51.39667161199904, dt = 0.5006490796966663, EEst = 0.334338043753723
[ Info: Step rejected: t = 51.39667161199904, EEst = 10.022519665615958
[ Info: Step accepted: t = 51.64727781943318, dt = 0.2506062074341413, EEst = 0.36148621231754047
[ Info: Step accepted: t = 51.88552836223247, dt = 0.2382505427992894, EEst = 0.14128402727193248
[ Info: Step accepted: t = 52.14549136374792, dt = 0.25996300151545204, EEst = 0.3121471648904589
[ Info: Step accepted: t = 52.38097166299152, dt = 0.2354802992435994, EEst = 0.05886731266919943
[ Info: Step accepted: t = 52.66802473801263, dt = 0.2870530750211127, EEst = 0.0757948356319883
[ Info: Step accepted: t = 52.96358607409703, dt = 0.295561336084395, EEst = 0.018957977592168353
[ Info: Step accepted: t = 53.34061249430706, dt = 0.3770264202100278, EEst = 0.02735552146843141
[ Info: Step accepted: t = 53.74954530945968, dt = 0.4089328151526151, EEst = 0.10167809457305443
[ Info: Step accepted: t = 54.12960040297119, dt = 0.3800550935115151, EEst = 0.009212027842462561
[ Info: Step accepted: t = 54.67870964316343, dt = 0.549109240192237, EEst = 0.4760291071868582
[ Info: Step rejected: t = 54.67870964316343, EEst = 7.378962241887892
[ Info: Step accepted: t = 54.93510203324485, dt = 0.25639239008142056, EEst = 0.38651644941784224
[ Info: Step accepted: t = 55.18350263246737, dt = 0.24840059922252378, EEst = 0.17416919627676597
[ Info: Step accepted: t = 55.44813132398019, dt = 0.26462869151282126, EEst = 0.30232447639554905
[ Info: Step accepted: t = 55.69297673759141, dt = 0.24484541361121553, EEst = 0.0713020799217713
[ Info: Step accepted: t = 55.98280285950865, dt = 0.2898261219172471, EEst = 0.07348724877561838
[ Info: Step accepted: t = 56.28714349791115, dt = 0.3043406384025035, EEst = 0.01977572922763387
[ Info: Step accepted: t = 56.67212860893003, dt = 0.38498511101887767, EEst = 0.03220762241088827
[ Info: Step accepted: t = 57.081634566717, dt = 0.4095059577869685, EEst = 0.0995300941639244
[ Info: Step accepted: t = 57.468381214001106, dt = 0.3867466472841048, EEst = 0.018413953107169083
[ Info: Step accepted: t = 57.97465642365804, dt = 0.5062752096569335, EEst = 0.3418507935499986
[ Info: Step rejected: t = 57.97465642365804, EEst = 9.349740725951937
[ Info: Step accepted: t = 58.22784216798828, dt = 0.25318574433023866, EEst = 0.3667946371049051
[ Info: Step accepted: t = 58.468480848199256, dt = 0.2406386802109765, EEst = 0.14516972951176507
[ Info: Step accepted: t = 58.730360510849195, dt = 0.2618796626499393, EEst = 0.3292233551679254
[ Info: Step accepted: t = 58.96632652937714, dt = 0.23596601852794769, EEst = 0.058418127532993726
[ Info: Step accepted: t = 59.25550966716571, dt = 0.289183137788569, EEst = 0.07699442873662159
[ Info: Step accepted: t = 59.5524286075812, dt = 0.29691894041548844, EEst = 0.01882082365042249
[ Info: Step accepted: t = 59.93204816438927, dt = 0.37961955680807535, EEst = 0.02815349117787128
[ Info: Step accepted: t = 60.34190098211826, dt = 0.4098528177289877, EEst = 0.10172767093304583
[ Info: Step accepted: t = 60.723662461030045, dt = 0.38176147891178747, EEst = 0.011917553356577196
[ Info: Step accepted: t = 61.255720981062616, dt = 0.532058520032569, EEst = 0.4109762296314885
[ Info: Step rejected: t = 61.255720981062616, EEst = 7.608092115778297
[ Info: Step accepted: t = 61.51349018098277, dt = 0.25776919992015396, EEst = 0.38374504754952177
[ Info: Step accepted: t = 61.760554087052235, dt = 0.24706390606946665, EEst = 0.16351727269752775
[ Info: Step accepted: t = 62.0259428027739, dt = 0.2653887157216605, EEst = 0.33891013852299257
[ Info: Step accepted: t = 62.266379049967256, dt = 0.24043624719335716, EEst = 0.06374103849536418
[ Info: Step accepted: t = 62.55814044767593, dt = 0.29176139770867743, EEst = 0.07683771986941637
[ Info: Step accepted: t = 62.85989029138901, dt = 0.3017498437130735, EEst = 0.01915345493694804
[ Info: Step accepted: t = 63.24467902662067, dt = 0.38478873523166907, EEst = 0.031174666686637476
[ Info: Step accepted: t = 63.65479855817164, dt = 0.41011953155096825, EEst = 0.10012914222996921
[ Info: Step accepted: t = 64.04079169693513, dt = 0.3859931387634924, EEst = 0.0173917646226724
[ Info: Step accepted: t = 64.55037935275085, dt = 0.5095876558157207, EEst = 0.344539570904241
[ Info: Step rejected: t = 64.55037935275085, EEst = 8.991930033195219
[ Info: Step accepted: t = 64.80516966132151, dt = 0.2547903085706671, EEst = 0.3695425983896348
[ Info: Step accepted: t = 65.04723161604929, dt = 0.24206195472778044, EEst = 0.14700071676633292
[ Info: Step accepted: t = 65.31035602531745, dt = 0.2631244092681596, EEst = 0.33699372290948476
[ Info: Step accepted: t = 65.5469074186754, dt = 0.2365513933579574, EEst = 0.05818631016227726
[ Info: Step accepted: t = 65.83751134263458, dt = 0.2906039239591838, EEst = 0.07750726466856347
[ Info: Step accepted: t = 66.1355171731204, dt = 0.2980058304858268, EEst = 0.018672482252474372
[ Info: Step accepted: t = 66.5171509962567, dt = 0.3816338231362951, EEst = 0.028869490057896307
[ Info: Step accepted: t = 66.92747219122246, dt = 0.4103211949657557, EEst = 0.10111614500726353
[ Info: Step accepted: t = 67.31076211244225, dt = 0.38328992121978533, EEst = 0.014141282527742188
[ Info: Step accepted: t = 67.83206259733778, dt = 0.5213004848955369, EEst = 0.37260634133023646
[ Info: Step rejected: t = 67.83206259733778, EEst = 7.999850966358766
[ Info: Step accepted: t = 68.08981375493715, dt = 0.2577511575993757, EEst = 0.37909762864553753
[ Info: Step accepted: t = 68.33535046359336, dt = 0.24553670865620753, EEst = 0.15553052556369742
[ Info: Step accepted: t = 68.60069547928434, dt = 0.2653450156909831, EEst = 0.35027724503252755
[ Info: Step accepted: t = 68.8390271865632, dt = 0.23833170727886283, EEst = 0.05994412719352318
[ Info: Step accepted: t = 69.13150413242559, dt = 0.29247694586238576, EEst = 0.07805052243981309
[ Info: Step accepted: t = 69.43185221609949, dt = 0.30034808367389576, EEst = 0.01875458530453244
[ Info: Step accepted: t = 69.8164642883159, dt = 0.38461207221641874, EEst = 0.030542513650272506
[ Info: Step accepted: t = 70.22688198269591, dt = 0.4104176943800104, EEst = 0.09996682541554948
[ Info: Step accepted: t = 70.61261059615994, dt = 0.38572861346401816, EEst = 0.017091013398249755
[ Info: Step accepted: t = 71.12302757361647, dt = 0.5104169774565327, EEst = 0.3413661255421053
[ Info: Step rejected: t = 71.12302757361647, EEst = 8.84655902935655
[ Info: Step accepted: t = 71.3787900557507, dt = 0.25576248213423675, EEst = 0.3703836101814198
[ Info: Step accepted: t = 71.62151823973399, dt = 0.24272818398328846, EEst = 0.14701999957861994
[ Info: Step accepted: t = 71.88541012450285, dt = 0.26389188476886893, EEst = 0.34042579338069906
[ Info: Step accepted: t = 72.12231752300933, dt = 0.2369073985064773, EEst = 0.057725460097480974
[ Info: Step accepted: t = 72.41391948235997, dt = 0.2916019593506481, EEst = 0.07776620565574073
[ Info: Step accepted: t = 72.71261911902874, dt = 0.29869963666877114, EEst = 0.018502527140997073
[ Info: Step accepted: t = 73.09573331665976, dt = 0.3831141976310211, EEst = 0.029410585674406086
[ Info: Step accepted: t = 73.506276060259, dt = 0.4105427435992308, EEst = 0.10022538920400687
[ Info: Step accepted: t = 73.89081892943206, dt = 0.38454286917306035, EEst = 0.015819724105661907
[ Info: Step accepted: t = 74.40530891788265, dt = 0.5144899884505905, EEst = 0.34885429679357804
[ Info: Step rejected: t = 74.40530891788265, EEst = 8.39064850075422
[ Info: Step accepted: t = 74.66264429430129, dt = 0.2573353764186321, EEst = 0.374577545699708
[ Info: Step accepted: t = 74.9069034096471, dt = 0.24425911534581926, EEst = 0.14999164240948687
[ Info: Step accepted: t = 75.17195650858413, dt = 0.26505309893702755, EEst = 0.3494744879877444
[ Info: Step accepted: t = 75.40941309002982, dt = 0.2374565814456903, EEst = 0.05794997349938028
[ Info: Step accepted: t = 75.7021463182901, dt = 0.29273322826028353, EEst = 0.07827700409814854
[ Info: Step accepted: t = 76.00182323339277, dt = 0.2996769151026597, EEst = 0.018468738187994375
[ Info: Step accepted: t = 76.38649057749792, dt = 0.38466734410514786, EEst = 0.030217231227408964
[ Info: Step accepted: t = 76.79707866000287, dt = 0.4105880825049454, EEst = 0.09943884721641429
[ Info: Step accepted: t = 77.1829226021593, dt = 0.3858439421564201, EEst = 0.017318644836587516
[ Info: Step accepted: t = 77.69233196218269, dt = 0.5094093600234024, EEst = 0.33394799259324187
[ Info: Step rejected: t = 77.69233196218269, EEst = 8.854724332618336
[ Info: Step accepted: t = 77.94861412159611, dt = 0.2562821594134222, EEst = 0.36979145024448706
[ Info: Step accepted: t = 78.19146277705622, dt = 0.2428486554601018, EEst = 0.14570431407617052
[ Info: Step accepted: t = 78.45578402756034, dt = 0.26432125050412436, EEst = 0.34112992979377255
[ Info: Step accepted: t = 78.69283776780377, dt = 0.23705374024341822, EEst = 0.057052657192911554
[ Info: Step accepted: t = 78.98514767245527, dt = 0.29230990465150053, EEst = 0.07788333913049648
[ Info: Step accepted: t = 79.28422867248604, dt = 0.2990810000307628, EEst = 0.01831623614970159
[ Info: Step accepted: t = 79.66842182641837, dt = 0.38419315393232684, EEst = 0.029775974223614263
[ Info: Step accepted: t = 80.07907711297203, dt = 0.4106552865536612, EEst = 0.09927555932067461
[ Info: Step accepted: t = 80.46461878542695, dt = 0.3855416724549223, EEst = 0.017091217959204243
[ Info: Step accepted: t = 80.97450466778082, dt = 0.5098858823538642, EEst = 0.3325781808816672
[ Info: Step rejected: t = 80.97450466778082, EEst = 8.724302208846762
[ Info: Step accepted: t = 81.2314360905995, dt = 0.2569314228186756, EEst = 0.3707893611546384
[ Info: Step accepted: t = 81.47472788286336, dt = 0.24329179226386577, EEst = 0.1459304131427483
[ Info: Step accepted: t = 81.73953125058021, dt = 0.26480336771684604, EEst = 0.3446927475738967
[ Info: Step accepted: t = 81.9767013633651, dt = 0.23717011278487546, EEst = 0.056775403865196875
[ Info: Step accepted: t = 82.26959782900909, dt = 0.29289646564399646, EEst = 0.07813475239386201
[ Info: Step accepted: t = 82.56902710716064, dt = 0.29942927815155057, EEst = 0.018237174110140697
[ Info: Step accepted: t = 82.95399975729326, dt = 0.3849726501326199, EEst = 0.030119516769718475
[ Info: Step accepted: t = 83.3646856182176, dt = 0.410685860924346, EEst = 0.09869867454349747
[ Info: Step accepted: t = 83.75092477224001, dt = 0.3862391540223992, EEst = 0.01788882717627396
[ Info: Step accepted: t = 84.25824658681184, dt = 0.5073218145718245, EEst = 0.32439310120838327
[ Info: Step rejected: t = 84.25824658681184, EEst = 8.973604028069062
[ Info: Step accepted: t = 84.51470350334225, dt = 0.25645691653041497, EEst = 0.36817628939526875
[ Info: Step accepted: t = 84.75730305209922, dt = 0.2425995487569641, EEst = 0.14355541108402467
[ Info: Step accepted: t = 85.02180986279318, dt = 0.26450681069395965, EEst = 0.339314751830188
[ Info: Step accepted: t = 85.25892548150662, dt = 0.23711561871344558, EEst = 0.05632100368556529
[ Info: Step accepted: t = 85.55171560203411, dt = 0.2927901205274822, EEst = 0.07784922153098633
[ Info: Step accepted: t = 85.85099703050165, dt = 0.2992814284675371, EEst = 0.018123956257662593
[ Info: Step accepted: t = 86.23600229678092, dt = 0.38500526627927745, EEst = 0.03001660226343805
[ Info: Step accepted: t = 86.64671531132333, dt = 0.4107130145424097, EEst = 0.09832438830996514
[ Info: Step accepted: t = 87.03307943875262, dt = 0.3863641274292945, EEst = 0.018114780524321264
[ Info: Step accepted: t = 87.53952100799835, dt = 0.5064415692457166, EEst = 0.32013126908556533
[ Info: Step rejected: t = 87.53952100799835, EEst = 9.00595292825
[ Info: Step accepted: t = 87.79613557990636, dt = 0.25661457190802256, EEst = 0.3676344805333711
[ Info: Step accepted: t = 88.03867774786639, dt = 0.2425421679600293, EEst = 0.1426489201009801
[ Info: Step accepted: t = 88.30332525585338, dt = 0.26464750798699604, EEst = 0.33900442470497977
[ Info: Step accepted: t = 88.54047725279669, dt = 0.23715199694330907, EEst = 0.05597369812167423
[ Info: Step accepted: t = 88.83354462942275, dt = 0.2930673766260526, EEst = 0.07786700247033407
[ Info: Step accepted: t = 89.13295161634072, dt = 0.2994069869179782, EEst = 0.018032247379692567
[ Info: Step accepted: t = 89.51839898775818, dt = 0.3854473714174524, EEst = 0.0301691363925105
[ Info: Step accepted: t = 89.92912517538346, dt = 0.4107261876252851, EEst = 0.09781965482628967
[ Info: Step accepted: t = 90.31593666616611, dt = 0.3868114907826434, EEst = 0.018641304977012194
[ Info: Step accepted: t = 90.8207283722003, dt = 0.5047917060341941, EEst = 0.31440475428462705
[ Info: Step rejected: t = 90.8207283722003, EEst = 9.163615905913842
[ Info: Step accepted: t = 91.07711857839816, dt = 0.256390206197843, EEst = 0.3659468584031398
[ Info: Step accepted: t = 91.3192554415505, dt = 0.24213686315234448, EEst = 0.14099450663958285
[ Info: Step accepted: t = 91.58379474700746, dt = 0.2645393054569662, EEst = 0.3352452384046153
[ Info: Step accepted: t = 91.82099887805234, dt = 0.23720413104486981, EEst = 0.055660556468856814
[ Info: Step accepted: t = 92.11409936985554, dt = 0.2931004918032083, EEst = 0.07765400982357297
[ Info: Step accepted: t = 92.41352055517523, dt = 0.29942118531968354, EEst = 0.01793386563924601
[ Info: Step accepted: t = 92.79919688888064, dt = 0.38567633370542476, EEst = 0.030204046658805522
[ Info: Step accepted: t = 93.20992082952614, dt = 0.4107239406454923, EEst = 0.09734821689333248
[ Info: Step accepted: t = 93.5970273910566, dt = 0.38710656153045225, EEst = 0.019024192132992807
[ Info: Step accepted: t = 94.10057464081586, dt = 0.5035472497592588, EEst = 0.3096681539475071
[ Info: Step rejected: t = 94.10057464081586, EEst = 9.262687306377092
[ Info: Step accepted: t = 94.35690764800057, dt = 0.25633300718470975, EEst = 0.3648197124323393
[ Info: Step accepted: t = 94.59880146445042, dt = 0.2418938164498386, EEst = 0.1397112390347855
[ Info: Step accepted: t = 94.86334816304127, dt = 0.264546698590842, EEst = 0.3328870681329033
[ Info: Step accepted: t = 95.10061996442299, dt = 0.23727180138172352, EEst = 0.05536995211135414
[ Info: Step accepted: t = 95.39385340948489, dt = 0.293233445061903, EEst = 0.07752527207161926
[ Info: Step accepted: t = 95.69335447118046, dt = 0.2995010616955599, EEst = 0.017841483119881575
[ Info: Step accepted: t = 96.07936138686826, dt = 0.3860069156877998, EEst = 0.030306810861576754
[ Info: Step accepted: t = 96.49007224201361, dt = 0.4107108551453577, EEst = 0.09683595239318779
[ Info: Step accepted: t = 96.87755737492121, dt = 0.3874851329076005, EEst = 0.01947411371345936
[ Info: Step accepted: t = 97.37973935406822, dt = 0.5021819791470049, EEst = 0.3048588408546944
[ Info: Step rejected: t = 97.37973935406822, EEst = 9.394780936909871
[ Info: Step accepted: t = 97.63590913486338, dt = 0.2561697807951614, EEst = 0.3634167608753504
[ Info: Step accepted: t = 97.87747712047066, dt = 0.24156798560727433, EEst = 0.13826050423702194
[ Info: Step accepted: t = 98.14197199443271, dt = 0.2644948739620538, EEst = 0.3294454283332489
[ Info: Step accepted: t = 98.37934450011461, dt = 0.23737250568190174, EEst = 0.05512683573933509
[ Info: Step accepted: t = 98.67263925458161, dt = 0.29329475446699416, EEst = 0.07731257214212435
[ Info: Step accepted: t = 98.97221264206789, dt = 0.2995733874862817, EEst = 0.017749216841384738
[ Info: Step accepted: t = 99.3585081455513, dt = 0.3862955034834124, EEst = 0.030395207129021683
[ Info: Step accepted: t = 99.76918816320696, dt = 0.41068001765567047, EEst = 0.09630778421836296
  0.006984 seconds (54.33 k allocations: 3.771 MiB)

[jClugstor]

@ChrisRackauckas This is ready to be looked at