Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.00133/0.00133, allocations: 111.1 kB / 20.44 MB, free: 1.352 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.00145/0.00145, allocations: 213.3 kB / 23.72 MB, free: 4.539 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.47/1.47, allocations: 230.6 MB / 257.5 MB, free: 7.82 MB / 206.1 MB " [Timeout remaining time 178] Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: "" <> buildModelFMU(Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL,fileNamePrefix="Modelica_4_1_0_Modelica_Electrical_Machines_Examples_InductionMachines_IMC_DOL",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL,fileNamePrefix="Modelica_4_1_0_Modelica_Electrical_Machines_Examples_InductionMachines_IMC_DOL",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.001833/0.001833, allocations: 51.86 kB / 377.7 MB, free: 2.988 MB / 302.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2759/0.2777, allocations: 53.36 MB / 431.1 MB, free: 6.676 MB / 334.1 MB Notification: Performance of NFInst.instantiate(Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL): time 0.01165/0.2893, allocations: 8.381 MB / 439.5 MB, free: 14.27 MB / 350.1 MB Notification: Performance of NFInst.instExpressions: time 0.006687/0.296, allocations: 2.886 MB / 442.4 MB, free: 11.37 MB / 350.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001559/0.2976, allocations: 59.62 kB / 442.4 MB, free: 11.31 MB / 350.1 MB Notification: Performance of NFTyping.typeComponents: time 0.001941/0.2995, allocations: 0.6133 MB / 443 MB, free: 10.7 MB / 350.1 MB Notification: Performance of NFTyping.typeBindings: time 0.00267/0.3022, allocations: 0.8195 MB / 443.8 MB, free: 9.871 MB / 350.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.0008688/0.3031, allocations: 367.5 kB / 444.2 MB, free: 9.512 MB / 350.1 MB Notification: Performance of NFFlatten.flatten: time 0.003252/0.3063, allocations: 2.661 MB / 446.9 MB, free: 6.836 MB / 350.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001648/0.308, allocations: 1.125 MB / 448 MB, free: 5.648 MB / 350.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.001882/0.3098, allocations: 1.238 MB / 449.2 MB, free: 4.406 MB / 350.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002432/0.3123, allocations: 1.467 MB / 450.7 MB, free: 2.934 MB / 350.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0005395/0.3128, allocations: 308 kB / 451 MB, free: 2.633 MB / 350.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0008514/0.3137, allocations: 407.8 kB / 451.4 MB, free: 2.234 MB / 350.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0008847/0.3146, allocations: 0.8959 MB / 452.3 MB, free: 1.336 MB / 350.1 MB Notification: Performance of NFVerifyModel.verify: time 0.001377/0.3159, allocations: 1.147 MB / 453.4 MB, free: 188 kB / 350.1 MB Notification: Performance of NFConvertDAE.convert: time 0.004504/0.3204, allocations: 4.138 MB / 457.6 MB, free: 12.03 MB / 366.1 MB Notification: Performance of FrontEnd - DAE generated: time 8.516e-06/0.3204, allocations: 4 kB / 457.6 MB, free: 12.02 MB / 366.1 MB Notification: Performance of FrontEnd: time 2.003e-06/0.3204, allocations: 0 / 457.6 MB, free: 12.02 MB / 366.1 MB Notification: Performance of Transformations before backend: time 0.0001197/0.3206, allocations: 0 / 457.6 MB, free: 12.02 MB / 366.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 524 * Number of variables: 524 Notification: Performance of Generate backend data structure: time 0.006859/0.3274, allocations: 2.865 MB / 460.4 MB, free: 9.109 MB / 366.1 MB Notification: Performance of prepare preOptimizeDAE: time 5.133e-05/0.3275, allocations: 8.031 kB / 460.5 MB, free: 9.102 MB / 366.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003754/0.3279, allocations: 295.5 kB / 460.7 MB, free: 8.801 MB / 366.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001006/0.3289, allocations: 339.1 kB / 461.1 MB, free: 8.469 MB / 366.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002822/0.3317, allocations: 1.488 MB / 462.6 MB, free: 6.938 MB / 366.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001325/0.3318, allocations: 156.2 kB / 462.7 MB, free: 6.781 MB / 366.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003164/0.3321, allocations: 204 kB / 462.9 MB, free: 6.582 MB / 366.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.004689/0.3368, allocations: 2.828 MB / 465.7 MB, free: 3.641 MB / 366.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 6.33e-05/0.3369, allocations: 15.94 kB / 465.8 MB, free: 3.625 MB / 366.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001897/0.3371, allocations: 83.98 kB / 465.8 MB, free: 3.543 MB / 366.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001151/0.3372, allocations: 87.94 kB / 465.9 MB, free: 3.457 MB / 366.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00398/0.3412, allocations: 2.33 MB / 468.3 MB, free: 1.125 MB / 366.1 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01415/0.3553, allocations: 7.538 MB / 475.8 MB, free: 9.348 MB / 382.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.002094/0.3574, allocations: 1.25 MB / 477 MB, free: 8.086 MB / 382.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001935/0.3593, allocations: 1.008 MB / 478.1 MB, free: 7.082 MB / 382.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.000215/0.3596, allocations: 52.95 kB / 478.1 MB, free: 7.031 MB / 382.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.061e-05/0.3596, allocations: 47.56 kB / 478.1 MB, free: 6.977 MB / 382.1 MB Notification: Performance of pre-optimization done (n=104): time 3.396e-06/0.3596, allocations: 0 / 478.1 MB, free: 6.977 MB / 382.1 MB Notification: Performance of matching and sorting (n=120): time 0.01409/0.3737, allocations: 5.924 MB / 484.1 MB, free: 1.012 MB / 382.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 5.141e-05/0.3738, allocations: 68.41 kB / 484.1 MB, free: 0.9336 MB / 382.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002782/0.3765, allocations: 1.544 MB / 485.7 MB, free: 15.38 MB / 398.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0001845/0.3767, allocations: 53.64 kB / 485.7 MB, free: 15.32 MB / 398.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0009336/0.3777, allocations: 1.013 MB / 486.7 MB, free: 14.3 MB / 398.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0005332/0.3782, allocations: 444.3 kB / 487.2 MB, free: 13.86 MB / 398.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004907/0.3787, allocations: 247.5 kB / 487.4 MB, free: 13.61 MB / 398.1 MB Notification: Performance of setup shared object (initialization): time 0.0001757/0.3789, allocations: 357.9 kB / 487.8 MB, free: 13.26 MB / 398.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001857/0.3807, allocations: 0.7339 MB / 488.5 MB, free: 12.52 MB / 398.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.002281/0.383, allocations: 1.055 MB / 489.6 MB, free: 11.34 MB / 398.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.004578/0.3876, allocations: 1.879 MB / 491.4 MB, free: 9.332 MB / 398.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.234e-05/0.3876, allocations: 4 kB / 491.4 MB, free: 9.328 MB / 398.1 MB Notification: Performance of matching and sorting (n=172) (initialization): time 0.004379/0.392, allocations: 2.354 MB / 493.8 MB, free: 6.953 MB / 398.1 MB Notification: Performance of prepare postOptimizeDAE: time 3.094e-05/0.392, allocations: 8 kB / 493.8 MB, free: 6.945 MB / 398.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.148e-05/0.392, allocations: 11.94 kB / 493.8 MB, free: 6.934 MB / 398.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.001036/0.393, allocations: 411.1 kB / 494.2 MB, free: 6.52 MB / 398.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001212/0.3943, allocations: 327.7 kB / 494.5 MB, free: 6.199 MB / 398.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005428/0.3997, allocations: 4.832 MB / 499.4 MB, free: 1.137 MB / 398.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001238/0.4009, allocations: 91.92 kB / 499.5 MB, free: 1.047 MB / 398.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001754/0.4011, allocations: 55.98 kB / 499.5 MB, free: 0.9922 MB / 398.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 42 * Number of states: 0 () * Number of discrete variables: 3 (idealCloser.control[3],idealCloser.control[2],idealCloser.control[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (156): * Single equations (assignments): 152 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 2 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 2 systems {(2,100.0%), (2,100.0%)} * Non-linear Jacobian (size): 0 systems * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(2,12,100.0%), (1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.001233/0.4023, allocations: 0.712 MB / 0.4885 GB, free: 276 kB / 398.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004086/0.4027, allocations: 170.9 kB / 0.4887 GB, free: 104 kB / 398.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003819/0.4066, allocations: 2.133 MB / 0.4908 GB, free: 13.94 MB / 414.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.424e-05/0.4066, allocations: 12 kB / 0.4908 GB, free: 13.93 MB / 414.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.428e-05/0.4066, allocations: 4 kB / 0.4908 GB, free: 13.93 MB / 414.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.291e-05/0.4066, allocations: 7.969 kB / 0.4908 GB, free: 13.92 MB / 414.1 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.008475/0.4151, allocations: 4.3 MB / 0.495 GB, free: 9.527 MB / 414.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.524e-06/0.4151, allocations: 0 / 0.495 GB, free: 9.527 MB / 414.1 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009551/0.416, allocations: 223.6 kB / 0.4952 GB, free: 9.309 MB / 414.1 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.001257/0.4173, allocations: 463.2 kB / 0.4956 GB, free: 8.844 MB / 414.1 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001056/0.4174, allocations: 43.98 kB / 0.4957 GB, free: 8.801 MB / 414.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006956/0.4244, allocations: 6.334 MB / 0.5019 GB, free: 2.121 MB / 414.1 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.196e-06/0.4244, allocations: 0 / 0.5019 GB, free: 2.121 MB / 414.1 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005335/0.4297, allocations: 3.185 MB / 0.505 GB, free: 14.88 MB / 430.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.001019/0.4307, allocations: 330.8 kB / 0.5053 GB, free: 14.55 MB / 430.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003889/0.4311, allocations: 27.98 kB / 0.5053 GB, free: 14.53 MB / 430.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00099/0.4321, allocations: 75.91 kB / 0.5054 GB, free: 14.45 MB / 430.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002931/0.4324, allocations: 120.7 kB / 0.5055 GB, free: 14.33 MB / 430.1 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.139e-05/0.4325, allocations: 36 kB / 0.5055 GB, free: 14.3 MB / 430.1 MB Notification: Performance of sorting global known variables: time 0.001702/0.4342, allocations: 1.056 MB / 0.5066 GB, free: 13.24 MB / 430.1 MB Notification: Performance of sort global known variables: time 1e-07/0.4342, allocations: 0 / 0.5066 GB, free: 13.24 MB / 430.1 MB Notification: Performance of remove unused functions: time 0.001537/0.4357, allocations: 463.9 kB / 0.507 GB, free: 12.79 MB / 430.1 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 10 * Number of states: 7 (aimc.inertiaRotor.w,aimc.i_0_s,aimc.idq_sr[1],aimc.idq_sr[2],aimc.idq_rr[1],aimc.idq_rr[2],quadraticLoadTorque.phi) * Number of discrete variables: 3 (idealCloser.control[1],idealCloser.control[2],idealCloser.control[3]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (104): * Single equations (assignments): 100 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 1 system {(2,100.0%)} * Non-linear Jacobian (size): 0 systems * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 3 systems {(2,12,100.0%), (1,1,100.0%), (2,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.005589/0.4413, allocations: 3.82 MB / 0.5107 GB, free: 8.902 MB / 430.1 MB Notification: Performance of simCode: created initialization part: time 0.005624/0.4469, allocations: 2.038 MB / 0.5127 GB, free: 6.832 MB / 430.1 MB Notification: Performance of simCode: created event and clocks part: time 6.002e-06/0.4469, allocations: 192 / 0.5127 GB, free: 6.832 MB / 430.1 MB Notification: Performance of simCode: created simulation system equations: time 0.003584/0.4505, allocations: 1.365 MB / 0.5141 GB, free: 5.43 MB / 430.1 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003358/0.4539, allocations: 447.9 kB / 0.5145 GB, free: 5 MB / 430.1 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03107/0.4849, allocations: 17.5 MB / 0.5316 GB, free: 2.926 MB / 446.1 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001762/0.4867, allocations: 1.254 MB / 0.5328 GB, free: 1.625 MB / 446.1 MB Notification: Performance of simCode: alias equations: time 0.001249/0.4879, allocations: 397.6 kB / 0.5332 GB, free: 1.23 MB / 446.1 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0012/0.4891, allocations: 0.8039 MB / 0.534 GB, free: 436 kB / 446.1 MB Notification: Performance of SimCode: time 8.42e-07/0.4891, allocations: 0 / 0.534 GB, free: 436 kB / 446.1 MB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3155/0.8047, allocations: 46.65 MB / 0.5795 GB, free: 68.21 MB / 446.1 MB Notification: Performance of buildModelFMU: Generate platform static: time 12.88/13.69, allocations: 11.83 kB / 0.5795 GB, free: 68.2 MB / 446.1 MB " [Timeout remaining time 646] (rm -f Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.pipe ; mkfifo Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.pipe ; head -c 1048576 < Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.pipe >> ../files/Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.sim & python3 -m fmpy simulate --output-file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv --start-time 0 --stop-time 1.5 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0001 Modelica_4_1_0_Modelica_Electrical_Machines_Examples_InductionMachines_IMC_DOL.fmu > Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.pipe 2>&1) [Timeout 52.5] diffSimulationResults("Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/Modelica/Electrical/Machines/Examples/InductionMachines/IMC_DOL/IMC_DOL.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660] "Error: Could not read variable aimc.is[1] in file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv. Warning: Get data of variable aimc.is[1] from file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv failed! Error: Could not read variable aimc.is[2] in file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv. Warning: Get data of variable aimc.is[2] from file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv failed! Error: Could not read variable loadInertia.phi in file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv. Warning: Get data of variable loadInertia.phi from file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv failed! Error: Could not read variable loadInertia.w in file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv. Warning: Get data of variable loadInertia.w from file Modelica_4.1.0_Modelica.Electrical.Machines.Examples.InductionMachines.IMC_DOL_res.csv failed! " [Timeout remaining time 660] Reference file matches [Calling sys.exit(0), Time elapsed: 16.764576856978238]