Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit3.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaTest 3.2.1/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.1/package.mo)
Using package Complex with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.1.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.1/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit3,fileNamePrefix="ModelicaTest_3_2_1_ModelicaTest_MultiBody_Joints_FreeMotionScalarInit3",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.1/package.mo): time 0.01163/0.01163, allocations: 105.4 kB / 15.06 MB, free: 6.027 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.1.mo): time 0.001248/0.001247, allocations: 173.6 kB / 15.94 MB, free: 5.961 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.1/package.mo): time 1.873/1.873, allocations: 170.9 MB / 187.5 MB, free: 0.9961 MB / 154.7 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaTest 3.2.1/package.mo): time 0.287/0.287, allocations: 38.09 MB / 265.1 MB, free: 3.973 MB / 218.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004758/0.000476, allocations: 16 kB / 323.6 MB, free: 29.63 MB / 250.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1111/0.1116, allocations: 48.7 MB / 372.3 MB, free: 12.85 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit3): time 0.05426/0.1659, allocations: 34.83 MB / 407.1 MB, free: 9.918 MB / 314.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02463/0.1906, allocations: 8.675 MB / 415.8 MB, free: 1.215 MB / 314.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007717/0.1984, allocations: 167.6 kB / 416 MB, free: 1.051 MB / 314.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.006306/0.2048, allocations: 1.801 MB / 417.8 MB, free: 15.24 MB / 330.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01987/0.2247, allocations: 5.139 MB / 422.9 MB, free: 10.09 MB / 330.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003411/0.2281, allocations: 0.503 MB / 423.4 MB, free: 9.586 MB / 330.7 MB
Notification: Performance of NFFlatten.flatten: time 0.006219/0.2344, allocations: 2.324 MB / 425.7 MB, free: 7.258 MB / 330.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.009306/0.2438, allocations: 4.272 MB / 430 MB, free: 2.934 MB / 330.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002932/0.2468, allocations: 1.031 MB / 431 MB, free: 1.898 MB / 330.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003373/0.2502, allocations: 1.421 MB / 432.5 MB, free: 484 kB / 330.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001054/0.2513, allocations: 160 kB / 432.6 MB, free: 324 kB / 330.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.2907/0.542, allocations: 0.8932 MB / 433.5 MB, free: 13.73 MB / 330.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.003264/0.5453, allocations: 1.68 MB / 435.2 MB, free: 13.73 MB / 330.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.002599/0.548, allocations: 0.9368 MB / 436.1 MB, free: 13.7 MB / 330.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01127/0.5593, allocations: 6.293 MB / 442.4 MB, free: 13.28 MB / 330.7 MB
Notification: Performance of FrontEnd - DAE generated: time 3.246e-06/0.5594, allocations: 0 / 442.4 MB, free: 13.28 MB / 330.7 MB
Notification: Performance of FrontEnd: time 4.048e-06/0.5594, allocations: 0.75 kB / 442.4 MB, free: 13.28 MB / 330.7 MB
Notification: Performance of Transformations before backend: time 0.0003411/0.5597, allocations: 2.188 kB / 442.4 MB, free: 13.28 MB / 330.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1869
 * Number of variables: 1869
Notification: Performance of Generate backend data structure: time 0.01868/0.5784, allocations: 4.52 MB / 446.9 MB, free: 11.27 MB / 330.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.818e-05/0.5785, allocations: 12.91 kB / 446.9 MB, free: 11.27 MB / 330.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003746/0.5822, allocations: 0.8702 MB / 447.8 MB, free: 11.18 MB / 330.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02445/0.6067, allocations: 3.853 MB / 451.7 MB, free: 10.15 MB / 330.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00873/0.6155, allocations: 2.526 MB / 454.2 MB, free: 9.355 MB / 330.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004062/0.616, allocations: 263.2 kB / 454.5 MB, free: 9.348 MB / 330.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002667/0.6187, allocations: 347.5 kB / 454.8 MB, free: 9.344 MB / 330.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03775/0.6565, allocations: 12.61 MB / 467.4 MB, free: 6.16 MB / 330.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002583/0.6568, allocations: 33.36 kB / 467.4 MB, free: 6.152 MB / 330.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002367/0.6592, allocations: 164.1 kB / 467.6 MB, free: 6.152 MB / 330.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.01039/0.6696, allocations: 2.747 MB / 470.3 MB, free: 5.555 MB / 330.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04709/0.7167, allocations: 11.56 MB / 481.9 MB, free: 14.2 MB / 346.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.1056/0.8224, allocations: 40.13 MB / 0.5098 GB, free: 11.07 MB / 378.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01824/0.8407, allocations: 4.962 MB / 0.5146 GB, free: 5.883 MB / 378.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01938/0.8601, allocations: 6.535 MB / 0.521 GB, free: 15.09 MB / 394.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.008e-05/0.8603, allocations: 56.55 kB / 0.5211 GB, free: 15.03 MB / 394.7 MB
Notification: Performance of pre-optimization done (n=228): time 7.033e-06/0.8603, allocations: 2.062 kB / 0.5211 GB, free: 15.03 MB / 394.7 MB
Notification: Performance of matching and sorting (n=237): time 0.07619/0.9365, allocations: 16.8 MB / 0.5375 GB, free: 14 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.878e-05/0.9366, allocations: 75.16 kB / 0.5376 GB, free: 13.91 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008382/0.945, allocations: 3.277 MB / 0.5408 GB, free: 10.62 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0007028/0.9458, allocations: 53.7 kB / 0.5408 GB, free: 10.56 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.004011/0.9498, allocations: 3.285 MB / 0.544 GB, free: 7.289 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001903/0.9517, allocations: 0.8943 MB / 0.5449 GB, free: 6.402 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00082/0.9526, allocations: 120 kB / 0.545 GB, free: 6.285 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0006776/0.9533, allocations: 0.5641 MB / 0.5456 GB, free: 5.715 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007437/0.9608, allocations: 2.386 MB / 0.5479 GB, free: 3.324 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01143/0.9722, allocations: 5.733 MB / 0.5535 GB, free: 11.98 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0102/0.9825, allocations: 3.691 MB / 0.5571 GB, free: 8.406 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001253/0.9827, allocations: 36 kB / 0.5571 GB, free: 8.371 MB / 426.7 MB
Notification: Performance of matching and sorting (n=803) (initialization): time 0.03692/1.02, allocations: 8.925 MB / 0.5658 GB, free: 144 kB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001567/1.02, allocations: 56 kB / 0.5659 GB, free: 88 kB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003057/1.02, allocations: 116 kB / 0.566 GB, free: 15.97 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009475/1.03, allocations: 1.168 MB / 0.5671 GB, free: 14.8 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01229/1.042, allocations: 1.365 MB / 0.5685 GB, free: 13.55 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01444/1.056, allocations: 4.673 MB / 0.573 GB, free: 8.773 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009435/1.066, allocations: 319.8 kB / 0.5733 GB, free: 8.461 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001889/1.068, allocations: 352 kB / 0.5737 GB, free: 8.117 MB / 442.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 537
 * Number of states: 0 ()
 * Number of discrete variables: 27 (spring.color[3],spring.color[2],spring.color[1],spring.massColor[3],spring.massColor[2],spring.massColor[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],freeMotionScalarInit.arrowColor[3],freeMotionScalarInit.arrowColor[2],freeMotionScalarInit.arrowColor[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 (743):
 * Single equations (assignments): 735
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(3,100.0%) 3}
 * Non-linear torn systems: 1 {3 5}
Notification: Performance of prepare postOptimizeDAE: time 0.009011/1.077, allocations: 2.414 MB / 0.576 GB, free: 5.789 MB / 442.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001231/1.078, allocations: 300.1 kB / 0.5763 GB, free: 5.492 MB / 442.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0145/1.093, allocations: 4.445 MB / 0.5807 GB, free: 1.016 MB / 442.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001271/1.093, allocations: 47.52 kB / 0.5807 GB, free: 0.9727 MB / 442.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.556e-05/1.093, allocations: 7.938 kB / 0.5807 GB, free: 0.9648 MB / 442.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.839e-05/1.093, allocations: 11.97 kB / 0.5807 GB, free: 0.9531 MB / 442.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0343/1.127, allocations: 10.6 MB / 0.5911 GB, free: 6.238 MB / 458.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.856e-05/1.127, allocations: 8 kB / 0.5911 GB, free: 6.23 MB / 458.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00382/1.131, allocations: 383.4 kB / 0.5914 GB, free: 5.855 MB / 458.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003872/1.135, allocations: 0.6737 MB / 0.5921 GB, free: 5.172 MB / 458.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006262/1.136, allocations: 55.42 kB / 0.5922 GB, free: 5.121 MB / 458.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004563/1.14, allocations: 2.44 MB / 0.5945 GB, free: 2.547 MB / 458.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.212e-05/1.141, allocations: 11.89 kB / 0.5946 GB, free: 2.535 MB / 458.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.3284/1.469, allocations: 7.192 MB / 0.6016 GB, free: 167.7 MB / 458.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001161/1.47, allocations: 355.8 kB / 0.6019 GB, free: 167.6 MB / 458.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001073/1.471, allocations: 41.64 kB / 0.602 GB, free: 167.6 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002617/1.474, allocations: 139.8 kB / 0.6021 GB, free: 167.6 MB / 458.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006455/1.474, allocations: 134 kB / 0.6022 GB, free: 167.6 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002779/1.475, allocations: 66.03 kB / 0.6023 GB, free: 167.6 MB / 458.7 MB
Notification: Performance of sorting global known variables: time 0.005533/1.48, allocations: 2.006 MB / 0.6042 GB, free: 167.4 MB / 458.7 MB
Notification: Performance of sort global known variables: time 9.01e-07/1.48, allocations: 4.188 kB / 0.6042 GB, free: 167.4 MB / 458.7 MB
Notification: Performance of remove unused functions: time 0.007908/1.488, allocations: 1.089 MB / 0.6053 GB, free: 167.2 MB / 458.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 20
 * Number of states: 12 (freeMotionScalarInit.r_rel_a_1,freeMotionScalarInit.r_rel_a_2,freeMotionScalarInit.r_rel_a_3,freeMotionScalarInit.v_rel_a_1,freeMotionScalarInit.v_rel_a_2,freeMotionScalarInit.v_rel_a_3,freeMotionScalarInit.angle_1,freeMotionScalarInit.angle_2,freeMotionScalarInit.angle_3,body.w_a[1],body.w_a[2],body.w_a[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 (191):
 * Single equations (assignments): 182
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 2
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 2 {(2,100.0%),(3,100.0%)}
 * Non-linear Jacobian: 0
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(2,100.0%) 1}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.01866/1.507, allocations: 9.001 MB / 0.6141 GB, free: 162.8 MB / 458.7 MB
Notification: Performance of simCode: created initialization part: time 0.01419/1.521, allocations: 5.814 MB / 0.6198 GB, free: 160.8 MB / 458.7 MB
Notification: Performance of simCode: created event and clocks part: time 1.164e-05/1.521, allocations: 3.875 kB / 0.6198 GB, free: 160.8 MB / 458.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.006936/1.528, allocations: 2.416 MB / 0.6221 GB, free: 159.9 MB / 458.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003731/1.532, allocations: 423.2 kB / 0.6225 GB, free: 159.6 MB / 458.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1008/1.633, allocations: 115.5 MB / 0.7353 GB, free: 43.95 MB / 458.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006302/1.639, allocations: 3.822 MB / 0.739 GB, free: 40.09 MB / 458.7 MB
Notification: Performance of simCode: alias equations: time 0.007909/1.647, allocations: 2.056 MB / 0.741 GB, free: 38.04 MB / 458.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004571/1.652, allocations: 2.124 MB / 0.7431 GB, free: 35.91 MB / 458.7 MB
Notification: Performance of SimCode: time 1.172e-06/1.652, allocations: 0 / 0.7431 GB, free: 35.91 MB / 458.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4537/2.105, allocations: 76.44 MB / 0.8178 GB, free: 144.8 MB / 458.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.000262/2.106, allocations: 219.3 kB / 0.818 GB, free: 144.6 MB / 458.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 5.273/7.379, allocations: 0 / 0.818 GB, free: 144.6 MB / 458.7 MB
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_3.2.1_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit3_res.mat does not exist to compare? outputFormat=mat