Running command: translateModel(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|freeMotionScalarInit.angle_1|freeMotionScalarInit.angle_2|freeMotionScalarInit.angle_3|freeMotionScalarInit.derdd.1..u|freeMotionScalarInit.derdd.2..u|freeMotionScalarInit.derdd.3..u|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",fileNamePrefix="ModelicaTest_trunk_cpp_ModelicaTest.MultiBody.Joints.FreeMotionScalarInit4")
Notification: Performance of loadModel(ModelicaTest): time 2.35/2.35, allocations: 269 MB / 284.1 MB, free: 3.652 MB / 234.7 MB
Notification: Performance of FrontEnd - loaded program: time 3.365e-05/3.401e-05, allocations: 4 kB / 349 MB, free: 10.79 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1478/0.1478, allocations: 61.89 MB / 410.9 MB, free: 12.89 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.FreeMotionScalarInit4): time 0.3988/0.5467, allocations: 34.68 MB / 445.6 MB, free: 10.42 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02636/0.5731, allocations: 8.21 MB / 453.8 MB, free: 5.031 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01003/0.5832, allocations: 182.5 kB / 454 MB, free: 5.004 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.007356/0.5906, allocations: 1.821 MB / 455.8 MB, free: 4.426 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02141/0.612, allocations: 5.112 MB / 460.9 MB, free: 1.355 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003362/0.6154, allocations: 476.7 kB / 461.4 MB, free: 1.035 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.005497/0.621, allocations: 1.64 MB / 463 MB, free: 15.94 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.008083/0.6291, allocations: 3.792 MB / 466.8 MB, free: 13.76 MB / 378.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002033/0.6312, allocations: 0.8016 MB / 467.6 MB, free: 13.4 MB / 378.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002838/0.6341, allocations: 1.282 MB / 468.9 MB, free: 12.75 MB / 378.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00335/0.6375, allocations: 0.8774 MB / 469.8 MB, free: 12.37 MB / 378.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001403/0.6389, allocations: 126.6 kB / 469.9 MB, free: 12.37 MB / 378.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.003047/0.642, allocations: 1.61 MB / 471.5 MB, free: 11.01 MB / 378.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001627/0.6437, allocations: 268 kB / 471.8 MB, free: 10.75 MB / 378.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01025/0.654, allocations: 6.163 MB / 477.9 MB, free: 4.57 MB / 378.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.458e-06/0.654, allocations: 0 / 477.9 MB, free: 4.57 MB / 378.7 MB
Notification: Performance of FrontEnd: time 2.334e-06/0.654, allocations: 4 kB / 477.9 MB, free: 4.566 MB / 378.7 MB
Notification: Performance of Transformations before backend: time 0.0002243/0.6543, allocations: 0 / 477.9 MB, free: 4.566 MB / 378.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1849
 * Number of variables: 1849
Notification: Performance of Generate backend data structure: time 0.01536/0.6696, allocations: 4.494 MB / 482.4 MB, free: 4 kB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.922e-05/0.6697, allocations: 12.08 kB / 482.5 MB, free: 15.99 MB / 394.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02339/0.6931, allocations: 3.839 MB / 486.3 MB, free: 12.14 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007283/0.7005, allocations: 2.367 MB / 488.7 MB, free: 9.723 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003275/0.7008, allocations: 262.8 kB / 488.9 MB, free: 9.465 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001691/0.7025, allocations: 355.7 kB / 489.3 MB, free: 9.117 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03212/0.7347, allocations: 12.44 MB / 0.4899 GB, free: 12.21 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001642/0.7349, allocations: 35.64 kB / 0.49 GB, free: 12.17 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008976/0.7358, allocations: 163.8 kB / 0.4901 GB, free: 12.01 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007528/0.7434, allocations: 2.696 MB / 0.4928 GB, free: 9.312 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03594/0.7793, allocations: 11.4 MB / 0.5039 GB, free: 13.9 MB / 426.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.09556/0.875, allocations: 39.7 MB / 0.5427 GB, free: 5.297 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02476/0.8998, allocations: 4.885 MB / 0.5474 GB, free: 180 kB / 458.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.02351/0.9233, allocations: 6.812 MB / 0.5541 GB, free: 8.996 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.372e-05/0.9235, allocations: 52.5 kB / 0.5541 GB, free: 8.938 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=229): time 8.777e-06/0.9235, allocations: 4 kB / 0.5542 GB, free: 8.934 MB / 474.7 MB
Notification: Performance of matching and sorting (n=250): time 0.1038/1.027, allocations: 19.48 MB / 0.5732 GB, free: 5.227 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.369e-05/1.027, allocations: 77.34 kB / 0.5732 GB, free: 5.141 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01306/1.041, allocations: 2.9 MB / 0.5761 GB, free: 2.23 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006151/1.041, allocations: 57.7 kB / 0.5761 GB, free: 2.168 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.01202/1.053, allocations: 3.222 MB / 0.5793 GB, free: 14.9 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00618/1.06, allocations: 0.9329 MB / 0.5802 GB, free: 13.95 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00077/1.06, allocations: 120 kB / 0.5803 GB, free: 13.84 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.0007208/1.061, allocations: 0.5711 MB / 0.5809 GB, free: 13.25 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01309/1.074, allocations: 2.421 MB / 0.5832 GB, free: 10.83 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01449/1.089, allocations: 5.718 MB / 0.5888 GB, free: 3.473 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.009383/1.098, allocations: 3.717 MB / 0.5924 GB, free: 15.75 MB / 0.5105 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000106/1.098, allocations: 39.95 kB / 0.5925 GB, free: 15.71 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=806) (initialization): time 0.03571/1.134, allocations: 9.867 MB / 0.6021 GB, free: 5.828 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001079/1.134, allocations: 59.94 kB / 0.6022 GB, free: 5.77 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001769/1.134, allocations: 116 kB / 0.6023 GB, free: 5.656 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01714/1.152, allocations: 2.389 MB / 0.6046 GB, free: 3.262 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008319/1.16, allocations: 1.326 MB / 0.6059 GB, free: 1.934 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.3751/1.535, allocations: 11.14 MB / 0.6168 GB, free: 156.1 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005824/1.541, allocations: 330 kB / 0.6171 GB, free: 156 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001271/1.542, allocations: 346.3 kB / 0.6174 GB, free: 156 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 527
 * Number of states: 0 ()
 * Number of discrete variables: 32 (freeMotionScalarInit.arrow.arrow.arrowLine.twoHeadedArrow,freeMotionScalarInit.arrow.headAtOrigin,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.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 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (721):
 * Single equations (assignments): 713
 * 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: 0
 * Non-linear torn systems: 2 {4 5,3 27}
Notification: Performance of prepare postOptimizeDAE: time 0.006342/1.549, allocations: 2.358 MB / 0.6197 GB, free: 155.1 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007463/1.549, allocations: 302.6 kB / 0.62 GB, free: 155.1 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01409/1.564, allocations: 4.58 MB / 0.6245 GB, free: 153.5 MB / 0.5105 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001239/1.564, allocations: 47.7 kB / 0.6245 GB, free: 153.5 MB / 0.5105 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.616e-05/1.564, allocations: 5.797 kB / 0.6246 GB, free: 153.5 MB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.462e-05/1.564, allocations: 9.328 kB / 0.6246 GB, free: 153.5 MB / 0.5105 GB
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.03156/1.595, allocations: 10.92 MB / 0.6352 GB, free: 149.6 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.994e-05/1.595, allocations: 7.625 kB / 0.6352 GB, free: 149.6 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003709/1.599, allocations: 402.7 kB / 0.6356 GB, free: 149.6 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003573/1.603, allocations: 0.7032 MB / 0.6363 GB, free: 149.5 MB / 0.5105 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005393/1.603, allocations: 59.44 kB / 0.6364 GB, free: 149.5 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003935/1.607, allocations: 2.452 MB / 0.6388 GB, free: 148 MB / 0.5105 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.695e-06/1.607, allocations: 7.219 kB / 0.6388 GB, free: 148 MB / 0.5105 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01622/1.624, allocations: 7.449 MB / 0.646 GB, free: 144.9 MB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009674/1.625, allocations: 365.2 kB / 0.6464 GB, free: 144.7 MB / 0.5105 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001055/1.626, allocations: 38.91 kB / 0.6464 GB, free: 144.7 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002679/1.628, allocations: 145.4 kB / 0.6466 GB, free: 144.7 MB / 0.5105 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005721/1.629, allocations: 141.6 kB / 0.6467 GB, free: 144.6 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002571/1.629, allocations: 66.89 kB / 0.6468 GB, free: 144.6 MB / 0.5105 GB
Notification: Performance of sorting global known variables: time 0.004216/1.634, allocations: 1.971 MB / 0.6487 GB, free: 144 MB / 0.5105 GB
Notification: Performance of sort global known variables: time 5.41e-07/1.634, allocations: 0 / 0.6487 GB, free: 144 MB / 0.5105 GB
Notification: Performance of remove unused functions: time 0.006649/1.64, allocations: 1.136 MB / 0.6498 GB, free: 143.8 MB / 0.5105 GB
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,freeMotionScalarInit.derdd[1].u,freeMotionScalarInit.derdd[2].u,freeMotionScalarInit.derdd[3].u)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (202):
 * Single equations (assignments): 193
 * 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.0009655/1.641, allocations: 216.8 kB / 0.65 GB, free: 143.7 MB / 0.5105 GB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica trunk/Mechanics/MultiBody/Joints/FreeMotionScalarInit.mo:80:3-82:159:writable] Warning: Variable freeMotionScalarInit.angle_3 has attribute stateSelect=StateSelect.always, but was selected as a continuous variable.
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica trunk/Mechanics/MultiBody/Joints/FreeMotionScalarInit.mo:77:3-79:159:writable] Warning: Variable freeMotionScalarInit.angle_2 has attribute stateSelect=StateSelect.always, but was selected as a continuous variable.
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica trunk/Mechanics/MultiBody/Joints/FreeMotionScalarInit.mo:74:3-76:159:writable] Warning: Variable freeMotionScalarInit.angle_1 has attribute stateSelect=StateSelect.always, but was selected as a continuous variable.
Notification: Performance of simCode: created initialization part: time 0.0144/1.656, allocations: 6.066 MB / 0.6559 GB, free: 139.7 MB / 0.5105 GB
Notification: Performance of simCode: created event and clocks part: time 1.04e-05/1.656, allocations: 2 kB / 0.6559 GB, free: 139.7 MB / 0.5105 GB
Notification: Performance of simCode: created simulation system equations: time 0.006676/1.662, allocations: 2.492 MB / 0.6584 GB, free: 137.5 MB / 0.5105 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00325/1.666, allocations: 426.3 kB / 0.6588 GB, free: 137.1 MB / 0.5105 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02707/1.693, allocations: 13.77 MB / 0.6722 GB, free: 123.3 MB / 0.5105 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00618/1.699, allocations: 3.821 MB / 0.6759 GB, free: 119.4 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001819/1.701, allocations: 287.3 kB / 0.6762 GB, free: 119.1 MB / 0.5105 GB
Notification: Performance of SimCode: time 1.453e-06/1.701, allocations: 0 / 0.6762 GB, free: 119.1 MB / 0.5105 GB
Notification: Performance of Templates: time 0.1818/1.883, allocations: 112.3 MB / 0.7859 GB, free: 6.715 MB / 0.5105 GB