Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo) Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo) Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo) Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo) Running command: "" <> buildModelFMU(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_FreeMotionScalarInit5",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_FreeMotionScalarInit5",fmuType="me",version="2.0",platforms={"static"}) Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001325/0.001325, allocations: 103.7 kB / 17.63 MB, free: 5.523 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001396/0.001396, allocations: 212.6 kB / 18.58 MB, free: 4.578 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.457/1.457, allocations: 227.4 MB / 246.8 MB, free: 10.59 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2409/0.2409, allocations: 46.11 MB / 344.2 MB, free: 11.58 MB / 286.1 MB Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions. Notification: Performance of FrontEnd - loaded program: time 0.002291/0.002291, allocations: 81.89 kB / 417.8 MB, free: 19.62 MB / 302.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1199/0.1222, allocations: 62.44 MB / 480.2 MB, free: 5.16 MB / 350.1 MB Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5): time 0.01771/0.14, allocations: 13.8 MB / 494 MB, free: 7.293 MB / 366.1 MB Notification: Performance of NFInst.instExpressions: time 0.01052/0.1505, allocations: 4.399 MB / 498.4 MB, free: 2.883 MB / 366.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002542/0.1531, allocations: 79.75 kB / 498.5 MB, free: 2.805 MB / 366.1 MB Notification: Performance of NFTyping.typeComponents: time 0.005102/0.1583, allocations: 2.375 MB / 0.4891 GB, free: 432 kB / 366.1 MB Notification: Performance of NFTyping.typeBindings: time 0.005407/0.1637, allocations: 1.81 MB / 0.4909 GB, free: 14.6 MB / 382.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.002556/0.1663, allocations: 0.8808 MB / 0.4917 GB, free: 13.72 MB / 382.1 MB Notification: Performance of NFFlatten.flatten: time 0.006388/0.1727, allocations: 3.986 MB / 0.4956 GB, free: 9.727 MB / 382.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.00515/0.1779, allocations: 3.429 MB / 0.499 GB, free: 6.25 MB / 382.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002884/0.1808, allocations: 1.472 MB / 0.5004 GB, free: 4.773 MB / 382.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.003317/0.1842, allocations: 2.029 MB / 0.5024 GB, free: 2.738 MB / 382.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001166/0.1854, allocations: 320 kB / 0.5027 GB, free: 2.426 MB / 382.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002793/0.1882, allocations: 1.135 MB / 0.5038 GB, free: 1.289 MB / 382.1 MB Notification: Performance of NFScalarize.scalarize: time 0.2524/0.4406, allocations: 1.884 MB / 0.5057 GB, free: 16.62 MB / 382.1 MB Notification: Performance of NFVerifyModel.verify: time 0.005863/0.4466, allocations: 2.242 MB / 0.5078 GB, free: 16.07 MB / 382.1 MB Notification: Performance of NFConvertDAE.convert: time 0.0122/0.4588, allocations: 7.124 MB / 0.5148 GB, free: 15.14 MB / 382.1 MB Notification: Performance of FrontEnd - DAE generated: time 8.095e-06/0.4589, allocations: 1.094 kB / 0.5148 GB, free: 15.14 MB / 382.1 MB Notification: Performance of FrontEnd: time 1.372e-06/0.4589, allocations: 3.938 kB / 0.5148 GB, free: 15.14 MB / 382.1 MB Notification: Performance of Transformations before backend: time 0.000283/0.4592, allocations: 1.062 kB / 0.5148 GB, free: 15.14 MB / 382.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1710 * Number of variables: 1710 Notification: Performance of Generate backend data structure: time 0.01896/0.4781, allocations: 5.122 MB / 0.5198 GB, free: 13.22 MB / 382.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.74e-05/0.4782, allocations: 9.156 kB / 0.5198 GB, free: 13.22 MB / 382.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002911/0.4811, allocations: 0.8038 MB / 0.5206 GB, free: 13.14 MB / 382.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01182/0.493, allocations: 3.155 MB / 0.5237 GB, free: 12.84 MB / 382.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.007641/0.5007, allocations: 2.402 MB / 0.526 GB, free: 11.95 MB / 382.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003994/0.5011, allocations: 242.7 kB / 0.5263 GB, free: 11.88 MB / 382.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.00228/0.5034, allocations: 316 kB / 0.5266 GB, free: 11.81 MB / 382.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02053/0.5239, allocations: 11.4 MB / 0.5377 GB, free: 6.078 MB / 382.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0001063/0.5241, allocations: 30.41 kB / 0.5377 GB, free: 6.07 MB / 382.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000551/0.5247, allocations: 143.6 kB / 0.5379 GB, free: 6.008 MB / 382.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003462/0.5281, allocations: 2.522 MB / 0.5403 GB, free: 5.043 MB / 382.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02073/0.5489, allocations: 10.58 MB / 0.5507 GB, free: 12.21 MB / 398.1 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.06254/0.6115, allocations: 36.2 MB / 0.586 GB, free: 7.777 MB / 430.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.009312/0.6208, allocations: 4.29 MB / 0.5902 GB, free: 3.27 MB / 430.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.003486/0.6244, allocations: 2.111 MB / 0.5923 GB, free: 1.16 MB / 430.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.001478/0.6259, allocations: 1.316 MB / 0.5935 GB, free: 15.63 MB / 446.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.019e-05/0.6259, allocations: 67.92 kB / 0.5936 GB, free: 15.56 MB / 446.1 MB Notification: Performance of pre-optimization done (n=235): time 6.222e-06/0.626, allocations: 0 / 0.5936 GB, free: 15.56 MB / 446.1 MB Notification: Performance of matching and sorting (n=256): time 0.04611/0.6721, allocations: 13.69 MB / 0.607 GB, free: 1.824 MB / 446.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 7.169e-05/0.6722, allocations: 73.41 kB / 0.607 GB, free: 1.738 MB / 446.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004743/0.677, allocations: 2.907 MB / 0.6099 GB, free: 14.81 MB / 462.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0005941/0.6776, allocations: 57.7 kB / 0.6099 GB, free: 14.75 MB / 462.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.002647/0.6802, allocations: 3.001 MB / 0.6129 GB, free: 11.75 MB / 462.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.00151/0.6818, allocations: 0.9399 MB / 0.6138 GB, free: 10.81 MB / 462.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001963/0.6837, allocations: 1.159 MB / 0.6149 GB, free: 9.645 MB / 462.1 MB Notification: Performance of setup shared object (initialization): time 0.0001296/0.6839, allocations: 305.1 kB / 0.6152 GB, free: 9.344 MB / 462.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.004137/0.688, allocations: 2.334 MB / 0.6175 GB, free: 7.004 MB / 462.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.007359/0.6954, allocations: 5.556 MB / 0.6229 GB, free: 15.93 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.01179/0.7072, allocations: 8.657 MB / 0.6314 GB, free: 6.176 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.816e-05/0.7073, allocations: 32 kB / 0.6314 GB, free: 6.145 MB / 478.1 MB Notification: Performance of matching and sorting (n=775) (initialization): time 0.01727/0.7246, allocations: 8.585 MB / 0.6398 GB, free: 14.1 MB / 494.1 MB Notification: Performance of prepare postOptimizeDAE: time 7.889e-05/0.7247, allocations: 58.88 kB / 0.6398 GB, free: 14.05 MB / 494.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001555/0.7249, allocations: 116 kB / 0.64 GB, free: 13.93 MB / 494.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.004024/0.7289, allocations: 1.042 MB / 0.641 GB, free: 12.88 MB / 494.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004667/0.7336, allocations: 1.33 MB / 0.6423 GB, free: 11.55 MB / 494.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003319/0.7369, allocations: 2.608 MB / 0.6448 GB, free: 8.801 MB / 494.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004242/0.7412, allocations: 311.2 kB / 0.6451 GB, free: 8.5 MB / 494.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001295/0.7425, allocations: 336 kB / 0.6454 GB, free: 8.172 MB / 494.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 510 * Number of states: 0 () * Number of discrete variables: 29 (freeMotionScalarInit1.arrow.arrow.twoHeadedArrow,freeMotionScalarInit1.arrow.headAtOrigin,freeMotionScalarInit2.arrowColor[3],freeMotionScalarInit2.arrowColor[2],freeMotionScalarInit2.arrowColor[1],frame_a1.color_x[3],frame_a1.color_x[2],frame_a1.color_x[1],frame_a.color_x[3],frame_a.color_x[2],frame_a.color_x[1],body.sphereColor[3],body.sphereColor[2],body.sphereColor[1],freeMotionScalarInit1.arrowColor[3],freeMotionScalarInit1.arrowColor[2],freeMotionScalarInit1.arrowColor[1],world.groundColor[3],world.groundColor[2],world.groundColor[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (722): * Single equations (assignments): 713 * Array equations: 6 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 2 * Torn equation systems: 1 * 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%), (3,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): 1 system {(2,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.005866/0.7484, allocations: 2.279 MB / 0.6477 GB, free: 5.879 MB / 494.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006068/0.749, allocations: 296.1 kB / 0.6479 GB, free: 5.586 MB / 494.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01054/0.7596, allocations: 4.978 MB / 0.6528 GB, free: 0.543 MB / 494.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.034e-05/0.7597, allocations: 50.09 kB / 0.6529 GB, free: 0.4961 MB / 494.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.29e-05/0.7597, allocations: 4 kB / 0.6529 GB, free: 0.4922 MB / 494.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.242e-05/0.7598, allocations: 11.91 kB / 0.6529 GB, free: 492 kB / 494.1 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02537/0.7851, allocations: 11.45 MB / 0.6641 GB, free: 4.891 MB / 0.4981 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.678e-05/0.7852, allocations: 4.156 kB / 0.6641 GB, free: 4.887 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002025/0.7872, allocations: 419.3 kB / 0.6645 GB, free: 4.477 MB / 0.4981 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.003703/0.791, allocations: 0.9073 MB / 0.6653 GB, free: 3.559 MB / 0.4981 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003196/0.7913, allocations: 55.98 kB / 0.6654 GB, free: 3.504 MB / 0.4981 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00294/0.7942, allocations: 2.417 MB / 0.6678 GB, free: 0.9492 MB / 0.4981 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.12e-05/0.7943, allocations: 11.94 kB / 0.6678 GB, free: 0.9375 MB / 0.4981 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.013/0.8073, allocations: 7.388 MB / 0.675 GB, free: 9.383 MB / 0.5137 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0007844/0.8081, allocations: 345 kB / 0.6753 GB, free: 9.023 MB / 0.5137 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004512/0.8086, allocations: 45.48 kB / 0.6754 GB, free: 8.98 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001278/0.8099, allocations: 139.8 kB / 0.6755 GB, free: 8.844 MB / 0.5137 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003667/0.8102, allocations: 149.7 kB / 0.6756 GB, free: 8.699 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001842/0.8104, allocations: 73.72 kB / 0.6757 GB, free: 8.629 MB / 0.5137 GB Notification: Performance of sorting global known variables: time 0.003456/0.8139, allocations: 1.783 MB / 0.6774 GB, free: 6.844 MB / 0.5137 GB Notification: Performance of sort global known variables: time 2.21e-07/0.8139, allocations: 0 / 0.6774 GB, free: 6.844 MB / 0.5137 GB Notification: Performance of remove unused functions: time 0.005605/0.8195, allocations: 0.9873 MB / 0.6784 GB, free: 5.859 MB / 0.5137 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 33 * Number of states: 12 (freeMotionScalarInit1.r_rel_a_1,freeMotionScalarInit1.r_rel_a_2,freeMotionScalarInit1.r_rel_a_3,freeMotionScalarInit1.v_rel_a_1,freeMotionScalarInit1.v_rel_a_2,freeMotionScalarInit1.v_rel_a_3,freeMotionScalarInit2.angle_1,freeMotionScalarInit2.angle_2,freeMotionScalarInit2.angle_3,freeMotionScalarInit2.angle_d_1,freeMotionScalarInit2.angle_d_2,freeMotionScalarInit2.angle_d_3) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (206): * Single equations (assignments): 197 * Array equations: 6 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 2 * Torn equation systems: 1 * 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%), (3,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): 1 system {(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.01419/0.8337, allocations: 8.056 MB / 0.6863 GB, free: 13.63 MB / 0.5294 GB Notification: Performance of simCode: created initialization part: time 0.01891/0.8527, allocations: 10.07 MB / 0.6961 GB, free: 3.523 MB / 0.5294 GB Notification: Performance of simCode: created event and clocks part: time 1.623e-05/0.8527, allocations: 4 kB / 0.6961 GB, free: 3.52 MB / 0.5294 GB Notification: Performance of simCode: created simulation system equations: time 0.00549/0.8582, allocations: 2.56 MB / 0.6986 GB, free: 0.9062 MB / 0.5294 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003272/0.8615, allocations: 0.5259 MB / 0.6991 GB, free: 416 kB / 0.5294 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2947/1.156, allocations: 47.65 MB / 0.7457 GB, free: 176.6 MB / 0.545 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006283/1.163, allocations: 3.53 MB / 0.7491 GB, free: 174.7 MB / 0.545 GB Notification: Performance of simCode: alias equations: time 0.004374/1.167, allocations: 2.1 MB / 0.7512 GB, free: 173.7 MB / 0.545 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002835/1.17, allocations: 1.968 MB / 0.7531 GB, free: 171.8 MB / 0.545 GB Notification: Performance of SimCode: time 1.312e-06/1.17, allocations: 0 / 0.7531 GB, free: 171.8 MB / 0.545 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09973/1.27, allocations: 64.94 MB / 0.8165 GB, free: 107.2 MB / 0.545 GB Notification: Performance of buildModelFMU: Generate platform static: time 11.49/12.76, allocations: 1.375 kB / 0.8165 GB, free: 107.2 MB / 0.545 GB (rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.sim & python3 -m fmpy simulate --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5_res.csv --start-time 0 --stop-time 1.1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.00044 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_FreeMotionScalarInit5.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit5.pipe 2>&1)